Name RiJKDm3TwRvnShfckohDCDFpABFKDmABFKDmBjsYDmABFKDmFeMMMo_0
Workunit 1935904
Created 10 Sep 2019, 14:39:57 UTC
Sent 10 Sep 2019, 14:43:24 UTC
Report deadline 17 Sep 2019, 14:43:24 UTC
Received 11 Sep 2019, 3:01:54 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 3837
Run time 18 min 47 sec
CPU time 34 min 42 sec
Validate state Valid
Credit 100.68
Device peak FLOPS 38.57 GFLOPS
Application version ATLAS Simulation v0.83 (vbox64_mt_mcore_atlas)
x86_64-pc-linux-gnu
Peak working set size 246.63 MB
Peak swap size 9.84 GB
Peak disk usage 3.34 GB

Stderr output

<core_client_version>7.16.1</core_client_version>
<![CDATA[
<stderr_txt>
2019-09-10 22:42:51 (29583): vboxwrapper (7.7.26197): starting
2019-09-10 22:42:51 (29583): Feature: Checkpoint interval offset (257 seconds)
2019-09-10 22:42:51 (29583): Detected: VirtualBox VboxManage Interface (Version: 6.0.12)
2019-09-10 22:42:51 (29583): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-09-10 22:42:51 (29583): Successfully copied 'init_data.xml' to the shared directory.
2019-09-10 22:42:51 (29583): Create VM. (boinc_623ba2e9395e816e, slot#4)
2019-09-10 22:42:51 (29583): Setting Memory Size for VM. (10200MB)
2019-09-10 22:42:52 (29583): Setting CPU Count for VM. (8)
2019-09-10 22:42:52 (29583): Setting Chipset Options for VM.
2019-09-10 22:42:52 (29583): Setting Boot Options for VM.
2019-09-10 22:42:52 (29583): Setting Network Configuration for NAT.
2019-09-10 22:42:52 (29583): Enabling VM Network Access.
2019-09-10 22:42:52 (29583): Disabling USB Support for VM.
2019-09-10 22:42:52 (29583): Disabling COM Port Support for VM.
2019-09-10 22:42:52 (29583): Disabling LPT Port Support for VM.
2019-09-10 22:42:52 (29583): Disabling Audio Support for VM.
2019-09-10 22:42:52 (29583): Disabling Clipboard Support for VM.
2019-09-10 22:42:52 (29583): Disabling Drag and Drop Support for VM.
2019-09-10 22:42:52 (29583): Adding storage controller(s) to VM.
2019-09-10 22:42:52 (29583): Adding virtual disk drive to VM. (vm_image.vdi)
2019-09-10 22:42:52 (29583): Adding VirtualBox Guest Additions to VM.
2019-09-10 22:42:52 (29583): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-09-10 22:42:52 (29583): forwarding host port 46915 to guest port 80
2019-09-10 22:42:53 (29583): Enabling remote desktop for VM.
2019-09-10 22:42:53 (29583): Enabling shared directory for VM.
2019-09-10 22:42:53 (29583): Starting VM. (boinc_623ba2e9395e816e, slot#4)
2019-09-10 22:42:54 (29583): Successfully started VM. (PID = '30116')
2019-09-10 22:42:54 (29583): Reporting VM Process ID to BOINC.
2019-09-10 22:42:54 (29583): Guest Log: BIOS: VirtualBox 6.0.12
2019-09-10 22:42:54 (29583): Guest Log: CPUID EDX: 0x178bfbff
2019-09-10 22:42:54 (29583): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-09-10 22:42:54 (29583): VM state change detected. (old = 'poweroff', new = 'running')
2019-09-10 22:42:54 (29583): Detected: Web Application Enabled (http://localhost:46915)
2019-09-10 22:42:54 (29583): Detected: Remote Desktop Enabled (localhost:45807)
2019-09-10 22:42:54 (29583): Preference change detected
2019-09-10 22:42:54 (29583): Setting CPU throttle for VM. (100%)
2019-09-10 22:42:54 (29583): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 900 seconds))
2019-09-10 22:42:56 (29583): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-09-10 22:42:56 (29583): Guest Log: BIOS: Booting from Hard Disk...
2019-09-10 22:42:58 (29583): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-09-10 22:42:58 (29583): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2019-09-10 22:42:58 (29583): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2019-09-10 22:43:03 (29583): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-09-10 22:43:03 (29583): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-09-10 22:43:04 (29583): Guest Log: Checking CVMFS...
2019-09-10 22:43:09 (29583): Guest Log: CVMFS is ok
2019-09-10 22:43:09 (29583): Guest Log: Mounting shared directory
2019-09-10 22:43:09 (29583): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29
2019-09-10 22:43:09 (29583): Guest Log: vboxsf: Successfully loaded version 6.0.12 on 3.10.0-957.27.2.el7.x86_64 SMP mod_unload modversions  (LINUX_VERSION_CODE=0x30a00)
2019-09-10 22:43:09 (29583): Guest Log: Copying input files
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.492835 main     VBoxService 6.0.12 r133076 (verbosity: 0) linux.amd64 (Sep  3 2019 11:48:42) release log
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.492839 main     Log opened 2019-09-10T22:43:08.492821000Z
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.492928 main     OS Product: Linux
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.492951 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.492966 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.492981 main     Executable: /opt/VBoxGuestAdditions-6.0.12/sbin/VBoxService
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.492982 main     Process ID: 2061
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.492982 main     Package type: LINUX_64BITS_GENERIC
2019-09-10 22:43:10 (29583): Guest Log: 22:43:08.493890 main     6.0.12 r133076 started. Verbose level = 0
2019-09-10 22:43:10 (29583): Guest Log: Copied input files into RunAtlas.
2019-09-10 22:43:11 (29583): Guest Log: copied the webapp to /var/www
2019-09-10 22:43:11 (29583): Guest Log: This vm does not need to setup an http proxy
2019-09-10 22:43:11 (29583): Guest Log: ATHENA_PROC_NUMBER=8
2019-09-10 22:43:11 (29583): Guest Log:  *** Starting ATLAS job. (PandaID=4002876565 taskID=000649-2) ***
2019-09-10 22:43:20 (29583): Guest Log: 02:43:20.258255 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 411 762 922 000ns (GuestNow=1 568 169 800 258 188 000 ns GuestLast=1 568 155 388 495 266 000 ns fSetTimeLastLoop=true )
2019-09-10 23:01:31 (29583): Guest Log:  *** Job finished ***
2019-09-10 23:01:31 (29583): Guest Log:  *** The last 20 lines of the pilot log: ***
2019-09-10 23:01:31 (29583): Guest Log: 2019-09-11 03:01:30 UTC [wrapper] apfmon messages muted
2019-09-10 23:01:31 (29583): Guest Log: ---- find pandaID.out ----
2019-09-10 23:01:31 (29583): Guest Log: total 56
2019-09-10 23:01:31 (29583): Guest Log: -rw-------.  1 atlas atlas 11357 Jul 25 14:38 LICENSE
2019-09-10 23:01:31 (29583): Guest Log: -rw-------.  1 atlas atlas    20 Sep  9 11:04 MANIFEST.IN
2019-09-10 23:01:31 (29583): Guest Log: -rw-------.  1 atlas atlas    11 Sep 11 02:43 pandaIDs.out
2019-09-10 23:01:31 (29583): Guest Log: drwx------. 14 atlas atlas   216 Sep 11 02:43 pilot
2019-09-10 23:01:31 (29583): Guest Log: -rwx------.  1 atlas atlas 20136 Sep  9 11:04 pilot.py
2019-09-10 23:01:31 (29583): Guest Log: -rw-------.  1 atlas atlas     9 Sep  9 11:04 PILOTVERSION
2019-09-10 23:01:31 (29583): Guest Log: -rw-------.  1 atlas atlas  2251 Jul 25 14:38 README.md
2019-09-10 23:01:31 (29583): Guest Log: -rw-------.  1 atlas atlas   760 Aug 22 09:01 setup.py
2019-09-10 23:01:31 (29583): Guest Log: -rw-------.  1 atlas atlas   221 Jul 25 14:38 TODO.md
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas 11 Sep 11 02:43 /home/atlas/RunAtlas/pilot2/pandaIDs.out
2019-09-10 23:01:31 (29583): Guest Log: 4002876565
2019-09-10 23:01:31 (29583): Guest Log: 2019-09-11 03:01:30 UTC [wrapper] Test setup, not cleaning
2019-09-10 23:01:31 (29583): Guest Log: 2019-09-11 03:01:30 UTC [wrapper] ==== wrapper stdout END ====
2019-09-10 23:01:31 (29583): Guest Log: 2019-09-11 03:01:30 UTC [wrapper] ==== wrapper stderr END ====
2019-09-10 23:01:31 (29583): Guest Log: 2019-09-11 03:01:30 UTC [wrapper] wrapper wrapperexiting ec=0, duration=1099
2019-09-10 23:01:31 (29583): Guest Log: 2019-09-11 03:01:30 UTC [wrapper] apfmon messages muted
2019-09-10 23:01:31 (29583): Guest Log:  *** Error codes and diagnostics ***
2019-09-10 23:01:31 (29583): Guest Log:  *** Listing of results directory ***
2019-09-10 23:01:31 (29583): Guest Log: total 23568
2019-09-10 23:01:31 (29583): Guest Log: -rw-r--r--. 1 atlas atlas  259319 Sep 10 14:28 pilot2.tar.gz
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas    2958 Sep 10 14:39 pandaJobData.out
2019-09-10 23:01:31 (29583): Guest Log: -rwx------. 1 atlas atlas   12641 Sep 10 14:39 runpilot2-wrapper.sh
2019-09-10 23:01:31 (29583): Guest Log: -rw-r--r--. 1 atlas atlas    8955 Sep 10 22:43 init_data.xml
2019-09-10 23:01:31 (29583): Guest Log: -rw-r--r--. 1 atlas atlas  266067 Sep 10 22:43 input.tar.gz
2019-09-10 23:01:31 (29583): Guest Log: -rw-r--r--. 1 atlas atlas     815 Sep 10 22:43 RTE.tar.gz
2019-09-10 23:01:31 (29583): Guest Log: -rw-r--r--. 1 atlas atlas    8505 Sep 10 22:43 start_atlas.sh
2019-09-10 23:01:31 (29583): Guest Log: lrwxrwxrwx. 1 atlas atlas      20 Sep 11 02:43 EVNT.14296418._001447.pool.root.1 -> /data/./ATLAS.root_0
2019-09-10 23:01:31 (29583): Guest Log: drwxr-xr-x. 3 atlas atlas      17 Sep 11 02:43 APPS
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas    5077 Sep 11 02:43 queuedata.json
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas 4070517 Sep 11 02:43 agis_schedconf.cvmfs.json
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas 7548779 Sep 11 02:43 agis_ddmendpoints.json
2019-09-10 23:01:31 (29583): Guest Log: drwx------. 3 atlas atlas     229 Sep 11 02:43 pilot2
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas 9191393 Sep 11 03:00 HITS.000649-2082729-27006._078090.pool.root.1
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas     836 Sep 11 03:01 memory_monitor_summary.json
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas 1147881 Sep 11 03:01 log.000649-2082729-27006._078090.job.log.tgz.1
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas   11727 Sep 11 03:01 heartbeat.json
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas   11040 Sep 11 03:01 pilotlog.txt
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas  182752 Sep 11 03:01 log.14568781._078090.job.log.1
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas     495 Sep 11 03:01 RiJKDm3TwRvnShfckohDCDFpABFKDmABFKDmBjsYDmABFKDmFeMMMo.diag
2019-09-10 23:01:31 (29583): Guest Log: -rw-r--r--. 1 atlas atlas    6891 Sep 11 03:01 runtime_log.err
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas     499 Sep 11 03:01 output.list
2019-09-10 23:01:31 (29583): Guest Log: -rw-r--r--. 1 atlas atlas     618 Sep 11 03:01 runtime_log
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas 1351680 Sep 11 03:01 result.tar.gz
2019-09-10 23:01:31 (29583): Guest Log: Looking for outputfile HITS.000649-2082729-27006._078090.pool.root.1
2019-09-10 23:01:31 (29583): Guest Log: HITS file was successfully produced
2019-09-10 23:01:31 (29583): Guest Log: -rw-------. 1 atlas atlas 9191393 Sep 11 03:00 /home/atlas/RunAtlas/HITS.000649-2082729-27006._078090.pool.root.1
2019-09-10 23:01:31 (29583): Guest Log: Successfully finished the ATLAS job!
2019-09-10 23:01:31 (29583): Guest Log: Copying the results back to the shared directory!
2019-09-10 23:01:31 (29583): Guest Log:  *** Success! Shutting down the machine. ***
2019-09-10 23:01:31 (29583): VM Completion File Detected.
2019-09-10 23:01:31 (29583): Powering off VM.
2019-09-10 23:01:32 (29583): Successfully stopped VM.
2019-09-10 23:01:32 (29583): Deregistering VM. (boinc_623ba2e9395e816e, slot#4)
2019-09-10 23:01:32 (29583): Removing network bandwidth throttle group from VM.
2019-09-10 23:01:32 (29583): Removing storage controller(s) from VM.
2019-09-10 23:01:32 (29583): Removing VM from VirtualBox.
2019-09-10 23:01:32 (29583): Removing virtual disk drive from VirtualBox.
23:01:37 (29583): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN