Name 2ZbNDm2tBDvnShfckohDCDFpABFKDmABFKDmWrlQDmABFKDmyzmXsm_0
Workunit 1912196
Created 31 Jul 2019, 22:05:40 UTC
Sent 31 Jul 2019, 22:19:30 UTC
Report deadline 7 Aug 2019, 22:19:30 UTC
Received 1 Aug 2019, 7:04:27 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 1849
Run time 8 hours 28 min 37 sec
CPU time 16 hours 22 min 20 sec
Validate state Valid
Credit 257.02
Device peak FLOPS 7.50 GFLOPS
Application version ATLAS Simulation v0.60 (vbox64_mt_mcore_atlas)
windows_x86_64
Peak working set size 98.08 MB
Peak swap size 136.18 MB
Peak disk usage 3.66 GB

Stderr output

<core_client_version>7.10.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-07-31 18:21:27 (67080): vboxwrapper (7.9.26200): starting
2019-07-31 18:21:27 (67080): Feature: Checkpoint interval offset (411 seconds)
2019-07-31 18:21:27 (67080): Detected: VirtualBox COM Interface (Version: 5.2.10)
2019-07-31 18:21:27 (67080): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-07-31 18:21:27 (67080): Successfully copied 'init_data.xml' to the shared directory.
2019-07-31 18:21:27 (67080): Create VM. (boinc_d158e1a967d2793f, slot#5)
2019-07-31 18:21:27 (67080): Setting Memory Size for VM. (4800MB)
2019-07-31 18:21:27 (67080): Setting CPU Count for VM. (2)
2019-07-31 18:21:27 (67080): Setting Chipset Options for VM.
2019-07-31 18:21:27 (67080): Setting Boot Options for VM.
2019-07-31 18:21:27 (67080): Enabling VM Network Access.
2019-07-31 18:21:27 (67080): Setting Network Configuration for NAT.
2019-07-31 18:21:27 (67080): Disabling USB Support for VM.
2019-07-31 18:21:27 (67080): Disabling COM Port Support for VM.
2019-07-31 18:21:27 (67080): Disabling LPT Port Support for VM.
2019-07-31 18:21:27 (67080): Disabling Audio Support for VM.
2019-07-31 18:21:27 (67080): Disabling Clipboard Support for VM.
2019-07-31 18:21:27 (67080): Disabling Drag and Drop Support for VM.
2019-07-31 18:21:27 (67080): Adding storage controller(s) to VM.
2019-07-31 18:21:27 (67080): Adding virtual disk drive to VM. (vm_image.vdi)
2019-07-31 18:21:28 (67080): Adding VirtualBox Guest Additions to VM.
2019-07-31 18:21:28 (67080): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-07-31 18:21:28 (67080): forwarding host port 59175 to guest port 80
2019-07-31 18:21:28 (67080): Enabling remote desktop for VM.
2019-07-31 18:21:28 (67080): Enabling shared directory for VM.
2019-07-31 18:21:28 (67080): Starting VM. (boinc_d158e1a967d2793f, slot#5)
2019-07-31 18:21:39 (67080): Guest Log: BIOS: VirtualBox 5.2.10

2019-07-31 18:21:39 (67080): Guest Log: CPUID EDX: 0x178bfbff

2019-07-31 18:21:39 (67080): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-07-31 18:21:39 (67080): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-07-31 18:21:39 (67080): Guest Log: BIOS: Booting from Hard Disk...

2019-07-31 18:21:39 (67080): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-07-31 18:21:39 (67080): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-07-31 18:21:39 (67080): Successfully started VM. (PID = '67832')
2019-07-31 18:21:39 (67080): Reporting VM Process ID to BOINC.
2019-07-31 18:21:44 (67080): VM state change detected. (old = 'poweroff', new = 'running')
2019-07-31 18:21:49 (67080): Detected: Web Application Enabled (http://localhost:59175)
2019-07-31 18:21:49 (67080): Detected: Remote Desktop Enabled (localhost:59176)
2019-07-31 18:21:54 (67080): Preference change detected
2019-07-31 18:21:54 (67080): Setting CPU throttle for VM. (100%)
2019-07-31 18:21:54 (67080): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-07-31 18:22:10 (67080): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-07-31 18:22:20 (67080): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013ffb8c10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-31 18:22:20 (67080): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013ffb8410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-31 18:22:20 (67080): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013ffb8010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-31 18:22:20 (67080): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013ffb8210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-07-31 18:23:10 (67080): Guest Log: Copying input files into RunAtlas.

2019-07-31 18:23:15 (67080): Guest Log: Copied input files into RunAtlas.

2019-07-31 18:23:20 (67080): Guest Log: copied the webapp to /var/www

2019-07-31 18:23:20 (67080): Guest Log: This vm does not need to setup http proxy

2019-07-31 18:23:20 (67080): Guest Log: ATHENA_PROC_NUMBER=2

2019-07-31 18:23:20 (67080): Guest Log: Starting ATLAS job. (PandaID=4428664881 taskID=18605019)

2019-07-31 19:26:38 (67080): VM state change detected. (old = 'running', new = 'paused')
2019-07-31 19:28:23 (67080): VM state change detected. (old = 'paused', new = 'running')
2019-07-31 20:03:47 (67080): Status Report: Elapsed Time: '6002.730785'
2019-07-31 20:03:47 (67080): Status Report: CPU Time: '11015.796875'
2019-07-31 20:36:32 (67080): VM state change detected. (old = 'running', new = 'paused')
2019-07-31 20:38:27 (67080): VM state change detected. (old = 'paused', new = 'running')
2019-07-31 21:45:50 (67080): Status Report: Elapsed Time: '12004.880413'
2019-07-31 21:45:50 (67080): Status Report: CPU Time: '22986.296875'
2019-07-31 21:58:21 (67080): VM state change detected. (old = 'running', new = 'paused')
2019-07-31 22:00:27 (67080): VM state change detected. (old = 'paused', new = 'running')
2019-07-31 23:08:10 (67080): VM state change detected. (old = 'running', new = 'paused')
2019-07-31 23:09:45 (67080): VM state change detected. (old = 'paused', new = 'running')
2019-07-31 23:29:43 (67080): Status Report: Elapsed Time: '18007.071983'
2019-07-31 23:29:43 (67080): Status Report: CPU Time: '34962.015625'
2019-08-01 00:24:35 (67080): VM state change detected. (old = 'running', new = 'paused')
2019-08-01 00:25:05 (67080): VM state change detected. (old = 'paused', new = 'running')
2019-08-01 01:10:22 (67080): Status Report: Elapsed Time: '24011.545673'
2019-08-01 01:10:22 (67080): Status Report: CPU Time: '46958.140625'
2019-08-01 01:34:06 (67080): VM state change detected. (old = 'running', new = 'paused')
2019-08-01 01:35:46 (67080): VM state change detected. (old = 'paused', new = 'running')
2019-08-01 02:40:59 (67080): VM state change detected. (old = 'running', new = 'paused')
2019-08-01 02:42:39 (67080): VM state change detected. (old = 'paused', new = 'running')
2019-08-01 02:53:56 (67080): Status Report: Elapsed Time: '30014.138269'
2019-08-01 02:53:56 (67080): Status Report: CPU Time: '58777.000000'
2019-08-01 03:00:56 (67080): Guest Log: The last 10 lines of the pilot log.

2019-08-01 03:00:56 (67080): Guest Log: -rw-------  1 atlas01 atlas01 11357 Jul 25 10:38 LICENSE

2019-08-01 03:00:56 (67080): Guest Log: drwx------ 14 atlas01 atlas01  4096 Jul 31 18:24 pilot

2019-08-01 03:00:56 (67080): Guest Log: -rwx------  1 atlas01 atlas01 20463 Jul 25 10:38 pilot.py

2019-08-01 03:00:56 (67080): Guest Log: -rw-------  1 atlas01 atlas01     8 Jul 25 10:38 PILOTVERSION

2019-08-01 03:00:56 (67080): Guest Log: -rw-------  1 atlas01 atlas01  2251 Jul 25 10:38 README.md

2019-08-01 03:00:56 (67080): Guest Log: -rw-------  1 atlas01 atlas01   221 Jul 25 10:38 TODO.md

2019-08-01 03:00:56 (67080): Guest Log: 2019-08-01 06:59:16 UTC [wrapper] Test setup, not cleaning

2019-08-01 03:00:56 (67080): Guest Log: 2019-08-01 06:59:16 UTC [wrapper] ==== wrapper stdout END ====

2019-08-01 03:00:56 (67080): Guest Log: 2019-08-01 06:59:16 UTC [wrapper] ==== wrapper stderr END ====

2019-08-01 03:00:56 (67080): Guest Log: Listing of results directory

2019-08-01 03:00:56 (67080): Guest Log: total 499636

2019-08-01 03:00:56 (67080): Guest Log: drwx------ 3 atlas01 atlas01      4096 Jul 25 10:38 pilot2

2019-08-01 03:00:56 (67080): Guest Log: -rw-r--r-- 1 atlas01 atlas01    249689 Jul 28 03:23 pilot2.tar.gz

2019-08-01 03:00:56 (67080): Guest Log: -rwx------ 1 atlas01 atlas01     15232 Jul 31 18:05 runpilot2-wrapper.sh

2019-08-01 03:00:56 (67080): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4468 Jul 31 18:05 queuedata.json

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01      2886 Jul 31 18:05 pandaJobData.out

2019-08-01 03:00:56 (67080): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 376858244 Jul 31 18:23 EVNT.17323843._000681.pool.root.1

2019-08-01 03:00:56 (67080): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8629 Jul 31 18:23 init_data.xml

2019-08-01 03:00:56 (67080): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    258978 Jul 31 18:23 input.tar.gz

2019-08-01 03:00:56 (67080): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       815 Jul 31 18:23 RTE.tar.gz

2019-08-01 03:00:56 (67080): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 Jul 31 18:23 start_atlas.sh

2019-08-01 03:00:56 (67080): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Jul 31 18:23 APPS

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01   4556095 Jul 31 18:24 agis_schedconf.cvmfs.json

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01   7395723 Jul 31 18:24 agis_ddmendpoints.json

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01 116290420 Aug  1 02:56 HITS.18605019._033771.pool.root.1

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01    632358 Aug  1 02:57 log.18605019._033771.job.log.tgz.1

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01     62342 Aug  1 02:58 heartbeat.json

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01      9358 Aug  1 02:59 pilotlog.txt

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01   1493188 Aug  1 02:59 log.18605019._033771.job.log.1

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01       500 Aug  1 02:59 2ZbNDm2tBDvnShfckohDCDFpABFKDmABFKDmWrlQDmABFKDmyzmXsm.diag

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01       391 Aug  1 02:59 output.list

2019-08-01 03:00:56 (67080): Guest Log: -rw-r--r-- 1 atlas01 atlas01      6760 Aug  1 02:59 runtime_log.err

2019-08-01 03:00:56 (67080): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 Aug  1 02:59 runtime_log

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01   3696640 Aug  1 02:59 result.tar.gz

2019-08-01 03:00:56 (67080): Guest Log: HITS file was successfully produced

2019-08-01 03:00:56 (67080): Guest Log: -rw------- 1 atlas01 atlas01 116290420 Aug  1 02:56 /home/atlas01/RunAtlas/HITS.18605019._033771.pool.root.1

2019-08-01 03:00:56 (67080): Guest Log: Successfully finished the ATLAS job!

2019-08-01 03:00:56 (67080): Guest Log: Copying the results back to the shared directory!

2019-08-01 03:01:01 (67080): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-08-01 03:01:01 (67080): Guest Log: Success! Shutting down the machine.

2019-08-01 03:01:01 (67080): VM Completion File Detected.
2019-08-01 03:01:01 (67080): Powering off VM.
2019-08-01 03:01:04 (67080): Successfully stopped VM.
2019-08-01 03:01:09 (67080): Deregistering VM. (boinc_d158e1a967d2793f, slot#5)
2019-08-01 03:01:09 (67080): Removing virtual disk drive(s) from VM.
2019-08-01 03:01:09 (67080): Removing network bandwidth throttle group from VM.
2019-08-01 03:01:09 (67080): Removing storage controller(s) from VM.
2019-08-01 03:01:09 (67080): Removing VM from VirtualBox.
03:01:14 (67080): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN