Name 521LDmabYkunShfckohDCDFpABFKDmABFKDmuKnMDmABFKDm6mRpln_0
Workunit 1896515
Created 13 May 2019, 22:28:15 UTC
Sent 13 May 2019, 22:28:20 UTC
Report deadline 20 May 2019, 22:28:20 UTC
Received 17 May 2019, 21:19:50 UTC
Server state Over
Outcome Validate error
Client state Done
Exit status 0 (0x00000000)
Computer ID 1060
Run time 13 hours 15 min 41 sec
CPU time 12 hours 42 min 15 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 3.12 GFLOPS
Application version ATLAS Simulation v0.60 (vbox64_mt_mcore_atlas)
windows_x86_64
Peak working set size 102.00 MB
Peak swap size 103.05 MB
Peak disk usage 1.98 GB

Stderr output

<core_client_version>7.6.9</core_client_version>
<![CDATA[
<stderr_txt>
2019-05-17 09:57:04 (1664): vboxwrapper (7.9.26200): starting
2019-05-17 09:57:04 (1664): Feature: Checkpoint interval offset (100 seconds)
2019-05-17 09:57:04 (1664): Detected: VirtualBox COM Interface (Version: 5.1.4)
2019-05-17 09:57:04 (1664): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-05-17 09:57:04 (1664): Successfully copied 'init_data.xml' to the shared directory.
2019-05-17 09:57:04 (1664): Create VM. (boinc_aab89e2e883efff6, slot#6)
2019-05-17 09:57:04 (1664): Setting Memory Size for VM. (3900MB)
2019-05-17 09:57:04 (1664): Setting CPU Count for VM. (1)
2019-05-17 09:57:04 (1664): Setting Chipset Options for VM.
2019-05-17 09:57:04 (1664): Setting Boot Options for VM.
2019-05-17 09:57:04 (1664): Enabling VM Network Access.
2019-05-17 09:57:04 (1664): Setting Network Configuration for NAT.
2019-05-17 09:57:04 (1664): Disabling USB Support for VM.
2019-05-17 09:57:04 (1664): Disabling COM Port Support for VM.
2019-05-17 09:57:04 (1664): Disabling LPT Port Support for VM.
2019-05-17 09:57:04 (1664): Disabling Audio Support for VM.
2019-05-17 09:57:04 (1664): Disabling Clipboard Support for VM.
2019-05-17 09:57:04 (1664): Disabling Drag and Drop Support for VM.
2019-05-17 09:57:04 (1664): Adding storage controller(s) to VM.
2019-05-17 09:57:04 (1664): Adding virtual disk drive to VM. (vm_image.vdi)
2019-05-17 09:57:05 (1664): Adding VirtualBox Guest Additions to VM.
2019-05-17 09:57:05 (1664): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-05-17 09:57:05 (1664): forwarding host port 57736 to guest port 80
2019-05-17 09:57:05 (1664): Enabling remote desktop for VM.
2019-05-17 09:57:05 (1664): Required extension pack not installed, remote desktop not enabled.
2019-05-17 09:57:05 (1664): Enabling shared directory for VM.
2019-05-17 09:57:05 (1664): Starting VM. (boinc_aab89e2e883efff6, slot#6)
2019-05-17 09:57:15 (1664): Guest Log: BIOS: VirtualBox 5.1.4

2019-05-17 09:57:15 (1664): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-05-17 09:57:15 (1664): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-05-17 09:57:15 (1664): Guest Log: BIOS: Booting from Hard Disk...

2019-05-17 09:57:15 (1664): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-05-17 09:57:15 (1664): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-05-17 09:57:15 (1664): Successfully started VM. (PID = '7196')
2019-05-17 09:57:15 (1664): Reporting VM Process ID to BOINC.
2019-05-17 09:57:20 (1664): VM state change detected. (old = 'poweroff', new = 'running')
2019-05-17 09:57:25 (1664): Detected: Web Application Enabled (http://localhost:57736)
2019-05-17 09:57:30 (1664): Preference change detected
2019-05-17 09:57:30 (1664): Setting CPU throttle for VM. (100%)
2019-05-17 09:57:31 (1664): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-05-17 09:57:36 (1664): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-05-17 09:57:56 (1664): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88010712da10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-05-17 09:57:56 (1664): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88010d7b7a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-05-17 09:57:56 (1664): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880107beaa10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-05-17 09:57:56 (1664): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880108316210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-05-17 09:59:12 (1664): Guest Log: Copying input files into RunAtlas.

2019-05-17 09:59:17 (1664): Guest Log: Copied input files into RunAtlas.

2019-05-17 09:59:41 (1664): Guest Log: copied the webapp to /var/www

2019-05-17 09:59:41 (1664): Guest Log: This vm does not need to setup http proxy

2019-05-17 09:59:43 (1664): Guest Log: core_number=1

2019-05-17 09:59:43 (1664): Guest Log: Starting ATLAS job. ( )

2019-05-17 11:37:35 (1664): Status Report: Elapsed Time: '6004.561481'
2019-05-17 11:37:35 (1664): Status Report: CPU Time: '5664.021908'
2019-05-17 13:17:37 (1664): Status Report: Elapsed Time: '12006.259602'
2019-05-17 13:17:37 (1664): Status Report: CPU Time: '11455.215830'
2019-05-17 14:57:37 (1664): Status Report: Elapsed Time: '18006.579042'
2019-05-17 14:57:37 (1664): Status Report: CPU Time: '17303.740121'
2019-05-17 16:37:38 (1664): Status Report: Elapsed Time: '24007.238531'
2019-05-17 16:37:38 (1664): Status Report: CPU Time: '23102.344091'
2019-05-17 18:17:40 (1664): Status Report: Elapsed Time: '30009.394207'
2019-05-17 18:17:40 (1664): Status Report: CPU Time: '28919.434180'
2019-05-17 19:43:38 (1664): Preference change detected
2019-05-17 19:43:38 (1664): Setting CPU throttle for VM. (100%)
2019-05-17 19:43:38 (1664): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-05-17 19:44:10 (1664): Preference change detected
2019-05-17 19:44:10 (1664): Setting CPU throttle for VM. (100%)
2019-05-17 19:44:10 (1664): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-05-17 19:45:42 (1664): Preference change detected
2019-05-17 19:45:42 (1664): Setting CPU throttle for VM. (100%)
2019-05-17 19:45:42 (1664): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-05-17 19:57:42 (1664): Status Report: Elapsed Time: '36011.319355'
2019-05-17 19:57:42 (1664): Status Report: CPU Time: '34631.145593'
2019-05-17 21:37:46 (1664): Status Report: Elapsed Time: '42015.984850'
2019-05-17 21:37:46 (1664): Status Report: CPU Time: '40327.974511'
2019-05-17 23:15:41 (1664): Guest Log: The last 10 lines of the pilot log.

2019-05-17 23:15:41 (1664): Guest Log: -rw-------  1 atlas01 atlas01 11357 Oct 10  2018 LICENSE

2019-05-17 23:15:41 (1664): Guest Log: drwx------ 14 atlas01 atlas01  4096 May 17 10:01 pilot

2019-05-17 23:15:41 (1664): Guest Log: -rwx------  1 atlas01 atlas01 21370 Apr 29 16:24 pilot.py

2019-05-17 23:15:41 (1664): Guest Log: -rw-------  1 atlas01 atlas01     7 May  7 17:15 PILOTVERSION

2019-05-17 23:15:41 (1664): Guest Log: -rw-------  1 atlas01 atlas01  2251 Mar 11 15:38 README.md

2019-05-17 23:15:41 (1664): Guest Log: -rw-------  1 atlas01 atlas01   221 Oct 10  2018 TODO.md

2019-05-17 23:15:41 (1664): Guest Log: 2019-05-17 21:15:42 UTC [wrapper] Test setup, not cleaning

2019-05-17 23:15:41 (1664): Guest Log: 2019-05-17 21:15:42 UTC [wrapper] ==== wrapper stdout END ====

2019-05-17 23:15:41 (1664): Guest Log: 2019-05-17 21:15:42 UTC [wrapper] ==== wrapper stderr END ====

2019-05-17 23:15:41 (1664): Guest Log: Listing of results directory

2019-05-17 23:15:41 (1664): Guest Log: total 493752

2019-05-17 23:15:41 (1664): Guest Log: drwx------ 3 atlas01 atlas01      4096 May  6 13:40 pilot2

2019-05-17 23:15:41 (1664): Guest Log: -rw-r--r-- 1 atlas01 atlas01    236270 May 13 16:43 pilot2.tar.gz

2019-05-17 23:15:41 (1664): Guest Log: -rwx------ 1 atlas01 atlas01     14490 May 14 00:28 runpilot2-wrapper.sh

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01      2885 May 14 00:28 pandaJobData.out

2019-05-17 23:15:41 (1664): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4444 May 14 00:28 queuedata.json

2019-05-17 23:15:41 (1664): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 374822248 May 17 09:59 EVNT.17323894._000314.pool.root.1

2019-05-17 23:15:41 (1664): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8132 May 17 09:59 init_data.xml

2019-05-17 23:15:41 (1664): Guest Log: -rwxr-xr-x 1 atlas01 atlas01    245113 May 17 09:59 input.tar.gz

2019-05-17 23:15:41 (1664): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       786 May 17 09:59 RTE.tar.gz

2019-05-17 23:15:41 (1664): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8659 May 17 09:59 start_atlas.sh

2019-05-17 23:15:41 (1664): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 May 17 09:59 APPS

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01   4870126 May 17 10:01 agis_schedconf.cvmfs.json

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01   7245969 May 17 10:01 agis_ddmendpoints.json

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01 109071738 May 17 23:13 HITS.17988802._015762.pool.root.1

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01       302 May 17 23:14 memory_monitor_summary.json

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01    351832 May 17 23:14 log.17988802._015762.job.log.tgz.1

2019-05-17 23:15:41 (1664): Guest Log: drwxrwx--- 2 atlas01 atlas01      4096 May 17 23:14 PanDA_Pilot-4343769968

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01     51575 May 17 23:14 heartbeat.json

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01   2034648 May 17 23:15 pilotlog.txt

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01   2047226 May 17 23:15 log.17988802._015762.job.log.1

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01       504 May 17 23:15 521LDmabYkunShfckohDCDFpABFKDmABFKDmuKnMDmABFKDm6mRpln.diag

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01       391 May 17 23:15 output.list

2019-05-17 23:15:41 (1664): Guest Log: -rw-r--r-- 1 atlas01 atlas01      7035 May 17 23:15 runtime_log.err

2019-05-17 23:15:41 (1664): Guest Log: -rw-r--r-- 1 atlas01 atlas01       692 May 17 23:15 runtime_log

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01   4505600 May 17 23:15 result.tar.gz

2019-05-17 23:15:41 (1664): Guest Log: HITS file was successfully produced

2019-05-17 23:15:41 (1664): Guest Log: -rw------- 1 atlas01 atlas01 109071738 May 17 23:13 /home/atlas01/RunAtlas/HITS.17988802._015762.pool.root.1

2019-05-17 23:15:46 (1664): Guest Log: Successfully finished the ATLAS job!

2019-05-17 23:15:46 (1664): Guest Log: Copying the results back to the shared directory!

2019-05-17 23:15:46 (1664): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-05-17 23:15:46 (1664): Guest Log: Success! Shutting down the machine.

2019-05-17 23:15:46 (1664): VM Completion File Detected.
2019-05-17 23:15:46 (1664): Powering off VM.
2019-05-17 23:15:48 (1664): Successfully stopped VM.
2019-05-17 23:15:53 (1664): Deregistering VM. (boinc_aab89e2e883efff6, slot#6)
2019-05-17 23:15:53 (1664): Removing virtual disk drive(s) from VM.
2019-05-17 23:15:53 (1664): Removing network bandwidth throttle group from VM.
2019-05-17 23:15:53 (1664): Removing storage controller(s) from VM.
2019-05-17 23:15:53 (1664): Removing VM from VirtualBox.
23:15:58 (1664): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN