Name 4mfNDmfZnYunShfckohDCDFpABFKDmABFKDmqBeKDmABFKDm2qrVGo_1
Workunit 1888545
Created 11 Apr 2019, 14:44:35 UTC
Sent 11 Apr 2019, 15:00:59 UTC
Report deadline 18 Apr 2019, 15:00:59 UTC
Received 11 Apr 2019, 23:58:59 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 3773
Run time 8 hours 51 min 25 sec
CPU time 16 hours 48 min 43 sec
Validate state Valid
Credit 426.20
Device peak FLOPS 8.35 GFLOPS
Application version ATLAS Simulation v0.60 (vbox64_mt_mcore_atlas)
windows_x86_64
Peak working set size 93.83 MB
Peak swap size 131.70 MB
Peak disk usage 1.98 GB

Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-04-11 17:03:14 (3924): vboxwrapper (7.9.26200): starting
2019-04-11 17:03:19 (3924): Feature: Checkpoint interval offset (235 seconds)
2019-04-11 17:03:19 (3924): Detected: VirtualBox VboxManage Interface (Version: 6.0.2)
2019-04-11 17:03:19 (3924): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-04-11 17:03:19 (3924): Successfully copied 'init_data.xml' to the shared directory.
2019-04-11 17:03:21 (3924): Create VM. (boinc_991a0281af1d4c5c, slot#5)
2019-04-11 17:03:24 (3924): Setting Memory Size for VM. (4800MB)
2019-04-11 17:03:25 (3924): Setting CPU Count for VM. (2)
2019-04-11 17:03:25 (3924): Setting Chipset Options for VM.
2019-04-11 17:03:25 (3924): Setting Boot Options for VM.
2019-04-11 17:03:26 (3924): Setting Network Configuration for NAT.
2019-04-11 17:03:27 (3924): Enabling VM Network Access.
2019-04-11 17:03:29 (3924): Disabling USB Support for VM.
2019-04-11 17:03:29 (3924): Disabling COM Port Support for VM.
2019-04-11 17:03:29 (3924): Disabling LPT Port Support for VM.
2019-04-11 17:03:29 (3924): Disabling Audio Support for VM.
2019-04-11 17:03:31 (3924): Disabling Clipboard Support for VM.
2019-04-11 17:03:32 (3924): Disabling Drag and Drop Support for VM.
2019-04-11 17:03:32 (3924): Adding storage controller(s) to VM.
2019-04-11 17:03:33 (3924): Adding virtual disk drive to VM. (vm_image.vdi)
2019-04-11 17:03:35 (3924): Adding VirtualBox Guest Additions to VM.
2019-04-11 17:03:36 (3924): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-04-11 17:03:36 (3924): forwarding host port 53587 to guest port 80
2019-04-11 17:03:38 (3924): Enabling remote desktop for VM.
2019-04-11 17:03:39 (3924): Enabling shared directory for VM.
2019-04-11 17:03:39 (3924): Starting VM using VboxManage interface. (boinc_991a0281af1d4c5c, slot#5)
2019-04-11 17:03:51 (3924): Successfully started VM. (PID = '4824')
2019-04-11 17:03:51 (3924): Reporting VM Process ID to BOINC.
2019-04-11 17:03:57 (3924): Guest Log: BIOS: VirtualBox 6.0.2

2019-04-11 17:03:57 (3924): Guest Log: CPUID EDX: 0x178bfbff

2019-04-11 17:03:57 (3924): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-04-11 17:03:57 (3924): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-04-11 17:03:57 (3924): Guest Log: BIOS: Booting from Hard Disk...

2019-04-11 17:03:57 (3924): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-04-11 17:03:57 (3924): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-04-11 17:03:57 (3924): VM state change detected. (old = 'poweroff', new = 'running')
2019-04-11 17:04:03 (3924): Detected: Web Application Enabled (http://localhost:53587)
2019-04-11 17:04:03 (3924): Detected: Remote Desktop Enabled (localhost:53588)
2019-04-11 17:04:09 (3924): Preference change detected
2019-04-11 17:04:09 (3924): Setting CPU throttle for VM. (100%)
2019-04-11 17:04:09 (3924): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds))
2019-04-11 17:04:23 (3924): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-04-11 17:04:35 (3924): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013fd4aa10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-11 17:04:35 (3924): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d4da010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-11 17:04:35 (3924): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013fd4a410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-11 17:04:35 (3924): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013fd4a810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-11 17:05:21 (3924): Guest Log: Copying input files into RunAtlas.

2019-04-11 17:05:27 (3924): Guest Log: Copied input files into RunAtlas.

2019-04-11 17:05:43 (3924): Guest Log: copied the webapp to /var/www

2019-04-11 17:05:43 (3924): Guest Log: This vm does not need to setup http proxy

2019-04-11 17:05:43 (3924): Guest Log: ATHENA_PROC_NUMBER=2

2019-04-11 17:05:43 (3924): Guest Log: Starting ATLAS job. ( )

2019-04-11 18:44:18 (3924): Status Report: Elapsed Time: '6005.772692'
2019-04-11 18:44:18 (3924): Status Report: CPU Time: '10643.093750'
2019-04-11 20:24:19 (3924): Status Report: Elapsed Time: '12010.092150'
2019-04-11 20:24:19 (3924): Status Report: CPU Time: '22532.375000'
2019-04-11 21:36:52 (3924): Preference change detected
2019-04-11 21:36:52 (3924): Setting CPU throttle for VM. (100%)
2019-04-11 21:36:52 (3924): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds))
2019-04-11 22:04:22 (3924): Status Report: Elapsed Time: '18012.530746'
2019-04-11 22:04:22 (3924): Status Report: CPU Time: '34395.781250'
2019-04-11 23:44:27 (3924): Status Report: Elapsed Time: '24017.644711'
2019-04-11 23:44:27 (3924): Status Report: CPU Time: '46259.781250'
2019-04-12 01:24:37 (3924): Status Report: Elapsed Time: '30025.446186'
2019-04-12 01:24:37 (3924): Status Report: CPU Time: '58155.140625'
2019-04-12 01:54:27 (3924): Guest Log: The last 10 lines of the pilot log.

2019-04-12 01:54:27 (3924): Guest Log:     <metadata att_name="adler32" att_value="cbff0ecb"/>

2019-04-12 01:54:27 (3924): Guest Log:   </File>

2019-04-12 01:54:27 (3924): Guest Log: </POOLFILECATALOG>

2019-04-12 01:54:27 (3924): Guest Log: 2019-04-12 00:54:23 UTC [wrapper] ---------

2019-04-12 01:54:27 (3924): Guest Log: 2019-04-12 00:54:23 UTC [wrapper] output list

2019-04-12 01:54:27 (3924): Guest Log: HITS.17602273._043292.pool.root.1 srm://srm.ndgf.org:8443;autodir=no;spacetoken=ATLASDATADISK/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/22/69/HITS.17602273._043292.pool.root.1:checksumtype=adler32:checksumvalue=cbff0ecb

2019-04-12 01:54:27 (3924): Guest Log: log.17602273._043292.job.log.tgz.1 srm://srm.ndgf.org:8443;autodir=no;spacetoken=ATLASDATADISK/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/a3/17/log.17602273._043292.job.log.tgz.1:checksumtype=adler32:checksumvalue=81407e5e

2019-04-12 01:54:27 (3924): Guest Log: 2019-04-12 00:54:23 UTC [wrapper] ==== wrapper stdout END ====

2019-04-12 01:54:27 (3924): Guest Log: 2019-04-12 00:54:23 UTC [wrapper] ==== wrapper stderr END ====

2019-04-12 01:54:27 (3924): Guest Log: Listing of results directory

2019-04-12 01:54:27 (3924): Guest Log: total 500008

2019-04-12 01:54:27 (3924): Guest Log: -rw-r--r-- 1 atlas01 atlas01   1064884 Apr 10 14:08 pilotcode.tar.gz

2019-04-12 01:54:27 (3924): Guest Log: -rwx------ 1 atlas01 atlas01     15214 Apr 11 14:01 runpilot3-wrapper.sh

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01      2885 Apr 11 14:01 pandaJobData.out

2019-04-12 01:54:27 (3924): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 375306488 Apr 11 18:05 EVNT.16926575._000857.pool.root.1

2019-04-12 01:54:27 (3924): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     10341 Apr 11 18:05 init_data.xml

2019-04-12 01:54:27 (3924): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   1073486 Apr 11 18:05 input.tar.gz

2019-04-12 01:54:27 (3924): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       786 Apr 11 18:05 RTE.tar.gz

2019-04-12 01:54:27 (3924): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8644 Apr 11 18:05 start_atlas.sh

2019-04-12 01:54:27 (3924): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Apr 11 18:05 APPS

2019-04-12 01:54:27 (3924): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        16 Apr 11 18:06 RunJob.py -> pilot3/RunJob.py

2019-04-12 01:54:27 (3924): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        21 Apr 11 18:06 RunJobEvent.py -> pilot3/RunJobEvent.py

2019-04-12 01:54:27 (3924): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        16 Apr 11 18:06 VmPeak.py -> pilot3/VmPeak.py

2019-04-12 01:54:27 (3924): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        19 Apr 11 18:06 PILOTVERSION -> pilot3/PILOTVERSION

2019-04-12 01:54:27 (3924): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        15 Apr 11 18:06 pilot.py -> pilot3/pilot.py

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01        22 Apr 11 18:06 PILOT_INITDIR

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01        50 Apr 11 18:07 CURRENT_SITEWORKDIR

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01     11498 Apr 11 18:07 pilotlog.txt

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01         1 Apr 11 18:07 STATUSCODE

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01        11 Apr 11 18:07 pandaIDs.out

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01        19 Apr 11 18:07 START_TIME_4305729824

2019-04-12 01:54:27 (3924): Guest Log: -rw-r--r-- 1 atlas01 atlas01      3809 Apr 11 18:07 queuedata.json

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01      2885 Apr 11 18:07 pandaJobData_1.out

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01 115624514 Apr 12 02:50 HITS.17602273._043292.pool.root.1

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01       304 Apr 12 02:50 memory_monitor_summary.json

2019-04-12 01:54:27 (3924): Guest Log: drwx------ 6 atlas01 atlas01     12288 Apr 12 02:51 pilot3

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01   4835907 Apr 12 02:51 agis_schedconf.cvmfs.json

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01   7210745 Apr 12 02:51 agis_ddmendpoints.cvmfs.json

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01      1047 Apr 12 02:52 workdir_size-4305729824.json

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01    703589 Apr 12 02:52 log.17602273._043292.job.log.tgz.1

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01       924 Apr 12 02:52 OutputFiles-4305729824.xml

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01      1024 Apr 12 02:52 metadata-surl.xml

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01     46215 Apr 12 02:52 panda_node_struct.pickle

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01       137 Apr 12 02:54 pilotlog-last.txt

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01      6638 Apr 12 02:54 jobSmallFiles.tgz

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01   1743941 Apr 12 02:54 log.17602273._043292.job.log.1

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01       511 Apr 12 02:54 4mfNDmfZnYunShfckohDCDFpABFKDmABFKDmqBeKDmABFKDm2qrVGo.diag

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01       463 Apr 12 02:54 output.list

2019-04-12 01:54:27 (3924): Guest Log: -rw-r--r-- 1 atlas01 atlas01      7357 Apr 12 02:54 runtime_log.err

2019-04-12 01:54:27 (3924): Guest Log: -rw-r--r-- 1 atlas01 atlas01       712 Apr 12 02:54 runtime_log

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01   4208640 Apr 12 02:54 result.tar.gz

2019-04-12 01:54:27 (3924): Guest Log: HITS file was successfully produced

2019-04-12 01:54:27 (3924): Guest Log: -rw------- 1 atlas01 atlas01 115624514 Apr 12 02:50 /home/atlas01/RunAtlas/HITS.17602273._043292.pool.root.1

2019-04-12 01:54:27 (3924): Guest Log: Successfully finished the ATLAS job!

2019-04-12 01:54:27 (3924): Guest Log: Copying the results back to the shared directory!

2019-04-12 01:54:27 (3924): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-04-12 01:54:27 (3924): Guest Log: Success! Shutting down the machine.

2019-04-12 01:54:27 (3924): VM Completion File Detected.
2019-04-12 01:54:27 (3924): Powering off VM.
2019-04-12 01:54:31 (3924): Successfully stopped VM.
2019-04-12 01:54:31 (3924): Deregistering VM. (boinc_991a0281af1d4c5c, slot#5)
2019-04-12 01:54:31 (3924): Removing network bandwidth throttle group from VM.
2019-04-12 01:54:31 (3924): Removing VM from VirtualBox.
01:54:37 (3924): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN