Task 2974321

Name	GRwMDmt7I8yn7Olcko1bjSoqABFKDmABFKDmlEgODmEHFKDmNQ3FSo_0
Workunit	2079272
Created	1 Jun 2021, 12:56:44 UTC
Sent	1 Jun 2021, 12:57:12 UTC
Report deadline	8 Jun 2021, 12:57:12 UTC
Received	1 Jun 2021, 18:25:37 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	4397
Run time	1 hours 2 min 6 sec
CPU time	12 min 23 sec
Validate state	Valid
Credit	29.69
Device peak FLOPS	37.95 GFLOPS
Application version	ATLAS Simulation v0.86 (vbox64_mt_mcore_atlas) windows_x86_64
Peak working set size	115.55 MB
Peak swap size	140.63 MB
Peak disk usage	3.00 GB
Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2021-06-01 10:25:52 (23796): Detected: vboxwrapper 26197
2021-06-01 10:25:52 (23796): Detected: BOINC client v7.7
2021-06-01 10:25:54 (23796): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2021-06-01 10:25:54 (23796): Successfully copied 'init_data.xml' to the shared directory.
2021-06-01 10:25:58 (23796): Create VM. (boinc_d41a435f3b4fe900, slot#14)
2021-06-01 10:25:59 (23796): Setting Memory Size for VM. (10200MB)
2021-06-01 10:25:59 (23796): Setting CPU Count for VM. (8)
2021-06-01 10:26:00 (23796): Setting Chipset Options for VM.
2021-06-01 10:26:00 (23796): Setting Boot Options for VM.
2021-06-01 10:26:00 (23796): Setting Network Configuration for NAT.
2021-06-01 10:26:00 (23796): Enabling VM Network Access.
2021-06-01 10:26:01 (23796): Disabling USB Support for VM.
2021-06-01 10:26:01 (23796): Disabling COM Port Support for VM.
2021-06-01 10:26:01 (23796): Disabling LPT Port Support for VM.
2021-06-01 10:26:01 (23796): Disabling Audio Support for VM.
2021-06-01 10:26:02 (23796): Disabling Clipboard Support for VM.
2021-06-01 10:26:02 (23796): Disabling Drag and Drop Support for VM.
2021-06-01 10:26:02 (23796): Adding storage controller(s) to VM.
2021-06-01 10:26:03 (23796): Adding virtual disk drive to VM. (vm_image.vdi)
2021-06-01 10:26:03 (23796): Adding VirtualBox Guest Additions to VM.
2021-06-01 10:26:03 (23796): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-06-01 10:26:04 (23796): forwarding host port 59906 to guest port 80
2021-06-01 10:26:04 (23796): Enabling remote desktop for VM.
2021-06-01 10:26:04 (23796): Required extension pack not installed, remote desktop not enabled.
2021-06-01 10:26:04 (23796): Enabling shared directory for VM.
2021-06-01 10:26:05 (23796): Starting VM using VBoxManage interface. (boinc_d41a435f3b4fe900, slot#14)
2021-06-01 10:26:09 (23796): Successfully started VM. (PID = '28896')
2021-06-01 10:26:09 (23796): Reporting VM Process ID to BOINC.
2021-06-01 10:26:09 (23796): Guest Log: BIOS: VirtualBox 5.2.8

2021-06-01 10:26:09 (23796): Guest Log: CPUID EDX: 0x178bfbff

2021-06-01 10:26:09 (23796): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-06-01 10:26:09 (23796): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-06-01 10:26:09 (23796): Detected: Web Application Enabled (http://localhost:59906)
2021-06-01 10:26:09 (23796): Preference change detected
2021-06-01 10:26:09 (23796): Setting CPU throttle for VM. (100%)
2021-06-01 10:26:09 (23796): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2021-06-01 10:26:12 (23796): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-06-01 10:26:12 (23796): Guest Log: BIOS: Booting from Hard Disk...

2021-06-01 10:26:13 (23796): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-06-01 10:26:13 (23796): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f

2021-06-01 10:26:13 (23796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f

2021-06-01 10:26:18 (23796): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-06-01 10:26:18 (23796): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-06-01 10:26:21 (23796): Guest Log: Checking CVMFS...

2021-06-01 10:26:24 (23796): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe:

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

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.000160 main     Log opened 2021-06-01T10:26:24.040915000Z

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.000254 main     OS Product: Linux

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.000284 main     OS Release: 3.10.0-957.27.2.el7.x86_64

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.000309 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.000336 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.000336 main     Process ID: 2120

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.000337 main     Package type: LINUX_64BITS_GENERIC

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.001512 main     5.2.32 r132073 started. Verbose level = 0

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.002546 main     Error: Service 'control' failed to initialize: VERR_INVALID_PARAMETER

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.002724 main     Session 0 is about to close ...

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.002751 main     Stopping all guest processes ...

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.002775 main     Closing all guest files ...

2021-06-01 10:26:25 (23796): Guest Log: 00:00:00.002942 main     Ended.

2021-06-01 10:26:26 (23796): Guest Log: Probing /cvmfs/atlas.cern.ch... OK

2021-06-01 10:26:26 (23796): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... OK

2021-06-01 10:26:26 (23796): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2021-06-01 10:26:27 (23796): Guest Log: Mounting shared directory

2021-06-01 10:26:27 (23796): Guest Log: Copying input files

2021-06-01 10:26:28 (23796): Guest Log: Copied input files into RunAtlas.

2021-06-01 10:26:28 (23796): Guest Log: copied the webapp to /var/www

2021-06-01 10:26:28 (23796): Guest Log: This vm does not need to setup an http proxy

2021-06-01 10:26:28 (23796): Guest Log: ATHENA_PROC_NUMBER=8

2021-06-01 10:26:28 (23796): Guest Log:  *** Starting ATLAS job. (PandaID=5073307682 taskID=NULL&cor) ***

2021-06-01 11:12:28 (23796): VM state change detected. (old = 'Running', new = 'Paused')
2021-06-01 14:07:38 (23796): VM state change detected. (old = 'Paused', new = 'Running')
2021-06-01 14:18:00 (23796): Guest Log:  *** Job finished ***

2021-06-01 14:18:00 (23796): Guest Log:  *** The last 20 lines of the pilot log: ***

2021-06-01 14:18:00 (23796): Guest Log:  *** Error codes and diagnostics ***

2021-06-01 14:18:00 (23796): Guest Log:     "exeErrorCode": 0,

2021-06-01 14:18:00 (23796): Guest Log:     "exeErrorDiag": "",

2021-06-01 14:18:00 (23796): Guest Log:     "pilotErrorCode": 0,

2021-06-01 14:18:00 (23796): Guest Log:     "pilotErrorDiag": "",

2021-06-01 14:18:00 (23796): Guest Log:  *** Listing of results directory ***

2021-06-01 14:18:00 (23796): Guest Log: total 8304

2021-06-01 14:18:00 (23796): Guest Log: -rwxr-xr-x. 1 atlas atlas    8646 Jun  1 10:26 init_data.xml

2021-06-01 14:18:00 (23796): Guest Log: -rwxr-xr-x. 1 atlas atlas  330769 Jun  1 10:26 input.tar.gz

2021-06-01 14:18:00 (23796): Guest Log: -rwxr-xr-x. 1 atlas atlas   16539 Jun  1 10:26 start_atlas.sh

2021-06-01 14:18:00 (23796): Guest Log: lrwxrwxrwx. 1 atlas atlas      20 Jun  1 10:26 EVNT.04972714._000038.pool.root.1 -> /data/./ATLAS.root_0

2021-06-01 14:18:00 (23796): Guest Log: -rw-r--r--. 1 atlas atlas    2609 Jun  1 10:26 pandaJob.out

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas 1041736 Jun  1 10:26 agis_schedconf.cvmfs.json

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas 1956148 Jun  1 10:26 cric_ddmendpoints.json

2021-06-01 14:18:00 (23796): Guest Log: drwx------. 4 atlas atlas     263 Jun  1 10:26 pilot2

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas 1857329 Jun  1 11:20 output.1.d2765eb6-3f50-4e9f-941f-7c20087a0e19_89344.pool.root

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas     999 Jun  1 11:21 memory_monitor_summary.json

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas  176948 Jun  1 11:21 d2765eb6-3f50-4e9f-941f-7c20087a0e19_89344.1.job.log.tgz

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas    6617 Jun  1 11:21 heartbeat.json

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas    8499 Jun  1 11:22 pilotlog.txt

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas  318940 Jun  1 11:22 d2765eb6-3f50-4e9f-941f-7c20087a0e19_89344.1.job.log

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas     536 Jun  1 11:22 output.list

2021-06-01 14:18:00 (23796): Guest Log: -rw-r--r--. 1 atlas atlas    9760 Jun  1 11:22 runtime_log.err

2021-06-01 14:18:00 (23796): Guest Log: -rw-r--r--. 1 atlas atlas     748 Jun  1 11:22 runtime_log

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas 2375680 Jun  1 11:22 result.tar.gz

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas     562 Jun  1 11:22 GRwMDmt7I8yn7Olcko1bjSoqABFKDmABFKDmlEgODmEHFKDmNQ3FSo.diag

2021-06-01 14:18:00 (23796): Guest Log: -rw-r--r--. 1 atlas atlas  320775 Jun  1  2021 pilot2.tar.gz

2021-06-01 14:18:00 (23796): Guest Log: -rwx------. 1 atlas atlas   20316 Jun  1  2021 runpilot2-wrapper.sh

2021-06-01 14:18:00 (23796): Guest Log: -rw-r--r--. 1 atlas atlas    3209 Jun  1  2021 queuedata.json

2021-06-01 14:18:00 (23796): Guest Log: Looking for outputfile output.1.d2765eb6-3f50-4e9f-941f-7c20087a0e19_89344.pool.root

2021-06-01 14:18:00 (23796): Guest Log: HITS file was successfully produced

2021-06-01 14:18:00 (23796): Guest Log: -rw-------. 1 atlas atlas 1857329 Jun  1 11:20 /home/atlas/RunAtlas/output.1.d2765eb6-3f50-4e9f-941f-7c20087a0e19_89344.pool.root

2021-06-01 14:18:00 (23796): Guest Log: Successfully finished the ATLAS job!

2021-06-01 14:18:00 (23796): Guest Log: Copying the results back to the shared directory!

2021-06-01 14:18:00 (23796): Guest Log:  *** Contents of shared directory: ***

2021-06-01 14:18:00 (23796): Guest Log: total 41232

2021-06-01 14:18:00 (23796): Guest Log: -rwxrwxrwx. 1 root root 37620382 Jun  1  2021 ATLAS.root_0

2021-06-01 14:18:00 (23796): Guest Log: -rwxrwxrwx. 1 root root  1857329 Jun  1 11:20 HITS.pool.root.1

2021-06-01 14:18:00 (23796): Guest Log: -rwxrwxrwx. 1 root root     8646 Jun  1  2021 init_data.xml

2021-06-01 14:18:00 (23796): Guest Log: -rwxrwxrwx. 1 root root   330769 Jun  1  2021 input.tar.gz

2021-06-01 14:18:00 (23796): Guest Log: -rwxrwxrwx. 1 root root  2375680 Jun  1  2021 result.tar.gz

2021-06-01 14:18:00 (23796): Guest Log: -rwxrwxrwx. 1 root root    16539 Jun  1  2021 start_atlas.sh

2021-06-01 14:18:00 (23796): Guest Log:  *** Success! Shutting down the machine. ***

2021-06-01 14:18:00 (23796): VM Completion File Detected.
2021-06-01 14:18:00 (23796): Powering off VM.
2021-06-01 14:23:01 (23796): VM did not power off when requested.
2021-06-01 14:23:01 (23796): VM was successfully terminated.
2021-06-01 14:23:01 (23796): Deregistering VM. (boinc_d41a435f3b4fe900, slot#14)
2021-06-01 14:23:02 (23796): Removing network bandwidth throttle group from VM.
2021-06-01 14:23:02 (23796): Removing VM from VirtualBox.
14:23:07 (23796): called boinc_finish(0)

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

Stderr output
