Task 3027770

Name	4zyMDmTLbozn7Olcko1bjSoqABFKDmABFKDmZr2WDm8LFKDm96dqCo_0
Workunit	2131350
Created	26 Sep 2021, 4:53:33 UTC
Sent	26 Sep 2021, 4:57:18 UTC
Report deadline	3 Oct 2021, 4:57:18 UTC
Received	26 Sep 2021, 5:31:04 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4202
Run time	31 min 7 sec
CPU time	10 min 50 sec
Validate state	Valid
Credit	12.83
Device peak FLOPS	5.49 GFLOPS
Application version	ATLAS Simulation v0.86 (vbox64_mt_mcore_atlas) windows_x86_64
Peak working set size	62.71 MB
Peak swap size	59.59 MB
Peak disk usage	3.01 GB
Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2021-09-26 00:59:38 (18400): Detected: vboxwrapper 26197
2021-09-26 00:59:38 (18400): Detected: BOINC client v7.7
2021-09-26 00:59:38 (18400): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2021-09-26 00:59:38 (18400): Successfully copied 'init_data.xml' to the shared directory.
2021-09-26 00:59:39 (18400): Create VM. (boinc_86c35ace324a6452, slot#10)
2021-09-26 00:59:40 (18400): Setting Memory Size for VM. (3900MB)
2021-09-26 00:59:40 (18400): Setting CPU Count for VM. (1)
2021-09-26 00:59:40 (18400): Setting Chipset Options for VM.
2021-09-26 00:59:41 (18400): Setting Boot Options for VM.
2021-09-26 00:59:41 (18400): Setting Network Configuration for NAT.
2021-09-26 00:59:41 (18400): Enabling VM Network Access.
2021-09-26 00:59:41 (18400): Disabling USB Support for VM.
2021-09-26 00:59:42 (18400): Disabling COM Port Support for VM.
2021-09-26 00:59:42 (18400): Disabling LPT Port Support for VM.
2021-09-26 00:59:42 (18400): Disabling Audio Support for VM.
2021-09-26 00:59:42 (18400): Disabling Clipboard Support for VM.
2021-09-26 00:59:43 (18400): Disabling Drag and Drop Support for VM.
2021-09-26 00:59:43 (18400): Adding storage controller(s) to VM.
2021-09-26 00:59:43 (18400): Adding virtual disk drive to VM. (vm_image.vdi)
2021-09-26 00:59:43 (18400): Adding VirtualBox Guest Additions to VM.
2021-09-26 00:59:44 (18400): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-09-26 00:59:44 (18400): forwarding host port 54180 to guest port 80
2021-09-26 00:59:44 (18400): Enabling remote desktop for VM.
2021-09-26 00:59:45 (18400): Required extension pack not installed, remote desktop not enabled.
2021-09-26 00:59:45 (18400): Enabling shared directory for VM.
2021-09-26 00:59:45 (18400): Starting VM using VBoxManage interface. (boinc_86c35ace324a6452, slot#10)
2021-09-26 00:59:49 (18400): Successfully started VM. (PID = '2384')
2021-09-26 00:59:49 (18400): Reporting VM Process ID to BOINC.
2021-09-26 00:59:49 (18400): Guest Log: BIOS: VirtualBox 6.1.26

2021-09-26 00:59:49 (18400): Guest Log: CPUID EDX: 0x178bfbff

2021-09-26 00:59:49 (18400): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-09-26 00:59:49 (18400): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-09-26 00:59:49 (18400): Detected: Web Application Enabled (http://localhost:54180)
2021-09-26 00:59:49 (18400): Preference change detected
2021-09-26 00:59:49 (18400): Setting CPU throttle for VM. (90%)
2021-09-26 00:59:50 (18400): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 900 seconds) or (Vbox_job.xml: 900 seconds))
2021-09-26 00:59:51 (18400): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-09-26 00:59:51 (18400): Guest Log: BIOS: Booting from Hard Disk...

2021-09-26 00:59:53 (18400): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-09-26 00:59:53 (18400): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d

2021-09-26 00:59:53 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e

2021-09-26 00:59:54 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e

2021-09-26 00:59:54 (18400): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f

2021-09-26 00:59:54 (18400): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f

2021-09-26 00:59:57 (18400): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-09-26 00:59:57 (18400): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-09-26 01:00:02 (18400): Guest Log: Checking CVMFS...

2021-09-26 01:00:09 (18400): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log

2021-09-26 01:00:09 (18400): Guest Log: 00:00:00.000155 main     Log opened 2021-09-26T01:00:07.026505000Z

2021-09-26 01:00:09 (18400): Guest Log: 00:00:00.000331 main     OS Product: Linux

2021-09-26 01:00:09 (18400): Guest Log: 00:00:00.000361 main     OS Release: 3.10.0-957.27.2.el7.x86_64

2021-09-26 01:00:09 (18400): Guest Log: 00:00:00.000384 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019

2021-09-26 01:00:09 (18400): Guest Log: 00:00:00.000405 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService

2021-09-26 01:00:09 (18400): Guest Log: 00:00:00.000406 main     Process ID: 1624

2021-09-26 01:00:09 (18400): Guest Log: 00:00:00.000406 main     Package type: LINUX_64BITS_GENERIC

2021-09-26 01:00:09 (18400): Guest Log: 00:00:00.001469 main     5.2.32 r132073 started. Verbose level = 0

2021-09-26 01:00:19 (18400): Guest Log: 00:00:10.007343 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 412 338 479 000ns (GuestNow=1 632 632 419 371 569 000 ns GuestLast=1 632 618 007 033 090 000 ns fSetTimeLastLoop=true )

2021-09-26 01:00:21 (18400): Guest Log: CVMFS is ok

2021-09-26 01:00:21 (18400): Guest Log: Mounting shared directory

2021-09-26 01:00:22 (18400): Guest Log: Copying input files

2021-09-26 01:00:22 (18400): Guest Log: Copied input files into RunAtlas.

2021-09-26 01:00:23 (18400): Guest Log: copied the webapp to /var/www

2021-09-26 01:00:23 (18400): Guest Log: This vm does not need to setup an http proxy

2021-09-26 01:00:23 (18400): Guest Log: core_number=1

2021-09-26 01:00:23 (18400): Guest Log:  *** Starting ATLAS job. (PandaID=5202302864 taskID=NULL&cor) ***

2021-09-26 01:25:34 (18400): Guest Log:  *** Job finished ***

2021-09-26 01:25:34 (18400): Guest Log:  *** The last 20 lines of the pilot log: ***

2021-09-26 01:25:34 (18400): Guest Log:  *** Error codes and diagnostics ***

2021-09-26 01:25:34 (18400): Guest Log:     "exeErrorCode": 0,

2021-09-26 01:25:34 (18400): Guest Log:     "exeErrorDiag": "",

2021-09-26 01:25:34 (18400): Guest Log:     "pilotErrorCode": 0,

2021-09-26 01:25:34 (18400): Guest Log:     "pilotErrorDiag": "",

2021-09-26 01:25:34 (18400): Guest Log:  *** Listing of results directory ***

2021-09-26 01:25:34 (18400): Guest Log: total 7400

2021-09-26 01:25:34 (18400): Guest Log: -rw-r--r--. 1 atlas atlas  344681 Sep 26 04:26 pilot2.tar.gz

2021-09-26 01:25:34 (18400): Guest Log: -rwx------. 1 atlas atlas   20816 Sep 26 04:53 runpilot2-wrapper.sh

2021-09-26 01:25:34 (18400): Guest Log: -rw-r--r--. 1 atlas atlas    4534 Sep 26 04:53 queuedata.json

2021-09-26 01:25:34 (18400): Guest Log: -rwxr-xr-x. 1 atlas atlas   11633 Sep 26 05:00 init_data.xml

2021-09-26 01:25:34 (18400): Guest Log: -rwxr-xr-x. 1 atlas atlas  354551 Sep 26 05:00 input.tar.gz

2021-09-26 01:25:34 (18400): Guest Log: -rwxr-xr-x. 1 atlas atlas   16541 Sep 26 05:00 start_atlas.sh

2021-09-26 01:25:34 (18400): Guest Log: lrwxrwxrwx. 1 atlas atlas      20 Sep 26 05:00 EVNT.04972714._000039.pool.root.1 -> /data/./ATLAS.root_0

2021-09-26 01:25:34 (18400): Guest Log: -rw-r--r--. 1 atlas atlas    2611 Sep 26 05:00 pandaJob.out

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas 1082156 Sep 26 05:01 agis_schedconf.cvmfs.json

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas 1944005 Sep 26 05:01 cric_ddmendpoints.json

2021-09-26 01:25:34 (18400): Guest Log: drwx------. 4 atlas atlas     260 Sep 26 05:01 pilot2

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas 1585218 Sep 26 05:24 output.1.7e27bf4b-9cee-4c4b-903b-b753175177ef_77070.pool.root

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas    1005 Sep 26 05:24 memory_monitor_summary.json

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas  162077 Sep 26 05:24 7e27bf4b-9cee-4c4b-903b-b753175177ef_77070.1.job.log.tgz

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas    7381 Sep 26 05:24 heartbeat.json

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas    1805 Sep 26 05:25 pilotlog.txt

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas  101650 Sep 26 05:25 7e27bf4b-9cee-4c4b-903b-b753175177ef_77070.1.job.log

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas     536 Sep 26 05:25 output.list

2021-09-26 01:25:34 (18400): Guest Log: -rw-r--r--. 1 atlas atlas     748 Sep 26 05:25 runtime_log

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas 1873920 Sep 26 05:25 result.tar.gz

2021-09-26 01:25:34 (18400): Guest Log: -rw-r--r--. 1 atlas atlas    9262 Sep 26 05:25 runtime_log.err

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas     552 Sep 26 05:25 4zyMDmTLbozn7Olcko1bjSoqABFKDmABFKDmZr2WDm8LFKDm96dqCo.diag

2021-09-26 01:25:34 (18400): Guest Log: Looking for outputfile output.1.7e27bf4b-9cee-4c4b-903b-b753175177ef_77070.pool.root

2021-09-26 01:25:34 (18400): Guest Log: HITS file was successfully produced

2021-09-26 01:25:34 (18400): Guest Log: -rw-------. 1 atlas atlas 1585218 Sep 26 05:24 /home/atlas/RunAtlas/output.1.7e27bf4b-9cee-4c4b-903b-b753175177ef_77070.pool.root

2021-09-26 01:25:34 (18400): Guest Log: Successfully finished the ATLAS job!

2021-09-26 01:25:34 (18400): Guest Log: Copying the results back to the shared directory!

2021-09-26 01:25:35 (18400): Guest Log:  *** Contents of shared directory: ***

2021-09-26 01:25:35 (18400): Guest Log: total 39848

2021-09-26 01:25:35 (18400): Guest Log: -rwxrwxrwx. 1 root root 36949600 Sep 26 04:59 ATLAS.root_0

2021-09-26 01:25:35 (18400): Guest Log: -rwxrwxrwx. 1 root root  1585218 Sep 26 05:24 HITS.pool.root.1

2021-09-26 01:25:35 (18400): Guest Log: -rwxrwxrwx. 1 root root    11633 Sep 26 04:59 init_data.xml

2021-09-26 01:25:35 (18400): Guest Log: -rwxrwxrwx. 1 root root   354551 Sep 26 04:57 input.tar.gz

2021-09-26 01:25:35 (18400): Guest Log: -rwxrwxrwx. 1 root root  1873920 Sep 26  2021 result.tar.gz

2021-09-26 01:25:35 (18400): Guest Log: -rwxrwxrwx. 1 root root    16541 Sep 26 04:57 start_atlas.sh

2021-09-26 01:25:35 (18400): Guest Log:  *** Success! Shutting down the machine. ***

2021-09-26 01:25:35 (18400): VM Completion File Detected.
2021-09-26 01:25:35 (18400): Powering off VM.
2021-09-26 01:30:36 (18400): VM did not power off when requested.
2021-09-26 01:30:36 (18400): VM was successfully terminated.
2021-09-26 01:30:36 (18400): Deregistering VM. (boinc_86c35ace324a6452, slot#10)
2021-09-26 01:30:36 (18400): Removing network bandwidth throttle group from VM.
2021-09-26 01:30:37 (18400): Removing VM from VirtualBox.
01:30:42 (18400): called boinc_finish(0)

</stderr_txt>
]]>
Development for LHC@home

Stderr output
