Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-04-12 10:02:55 (4388): vboxwrapper (7.9.26200): starting
2019-04-12 10:02:56 (4388): Feature: Checkpoint interval offset (263 seconds)
2019-04-12 10:02:56 (4388): Detected: VirtualBox VboxManage Interface (Version: 6.0.2)
2019-04-12 10:02:56 (4388): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-04-12 10:02:56 (4388): Successfully copied 'init_data.xml' to the shared directory.
2019-04-12 10:02:58 (4388): Create VM. (boinc_3eb817bca1173600, slot#2)
2019-04-12 10:02:58 (4388): Setting Memory Size for VM. (4800MB)
2019-04-12 10:02:59 (4388): Setting CPU Count for VM. (2)
2019-04-12 10:03:00 (4388): Setting Chipset Options for VM.
2019-04-12 10:03:01 (4388): Setting Boot Options for VM.
2019-04-12 10:03:02 (4388): Setting Network Configuration for NAT.
2019-04-12 10:03:02 (4388): Enabling VM Network Access.
2019-04-12 10:03:02 (4388): Disabling USB Support for VM.
2019-04-12 10:03:03 (4388): Disabling COM Port Support for VM.
2019-04-12 10:03:03 (4388): Disabling LPT Port Support for VM.
2019-04-12 10:03:03 (4388): Disabling Audio Support for VM.
2019-04-12 10:03:04 (4388): Disabling Clipboard Support for VM.
2019-04-12 10:03:05 (4388): Disabling Drag and Drop Support for VM.
2019-04-12 10:03:05 (4388): Adding storage controller(s) to VM.
2019-04-12 10:03:07 (4388): Adding virtual disk drive to VM. (vm_image.vdi)
2019-04-12 10:03:08 (4388): Adding VirtualBox Guest Additions to VM.
2019-04-12 10:03:08 (4388): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-04-12 10:03:08 (4388): forwarding host port 57729 to guest port 80
2019-04-12 10:03:09 (4388): Enabling remote desktop for VM.
2019-04-12 10:03:12 (4388): Enabling shared directory for VM.
2019-04-12 10:03:12 (4388): Starting VM using VboxManage interface. (boinc_3eb817bca1173600, slot#2)
2019-04-12 10:03:17 (4388): Successfully started VM. (PID = '3556')
2019-04-12 10:03:17 (4388): Reporting VM Process ID to BOINC.
2019-04-12 10:03:22 (4388): Guest Log: BIOS: VirtualBox 6.0.2

2019-04-12 10:03:22 (4388): Guest Log: CPUID EDX: 0x178bfbff

2019-04-12 10:03:22 (4388): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-04-12 10:03:22 (4388): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-04-12 10:03:22 (4388): Guest Log: BIOS: Booting from Hard Disk...

2019-04-12 10:03:22 (4388): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-04-12 10:03:22 (4388): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

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

2019-04-12 10:03:56 (4388): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013dfe8010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-12 10:03:56 (4388): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013dfe9210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-12 10:03:56 (4388): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013ea2e010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-12 10:03:56 (4388): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801447dd010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-12 10:05:02 (4388): Guest Log: Copying input files into RunAtlas.

2019-04-12 10:05:08 (4388): Guest Log: Copied input files into RunAtlas.

2019-04-12 10:05:36 (4388): Guest Log: copied the webapp to /var/www

2019-04-12 10:05:36 (4388): Guest Log: This vm does not need to setup http proxy

2019-04-12 10:05:36 (4388): Guest Log: ATHENA_PROC_NUMBER=2

2019-04-12 10:05:36 (4388): Guest Log: Starting ATLAS job. ( )

2019-04-12 11:43:37 (4388): Status Report: Elapsed Time: '6003.691830'
2019-04-12 11:43:37 (4388): Status Report: CPU Time: '10602.984375'
2019-04-12 13:23:37 (4388): Status Report: Elapsed Time: '12003.923258'
2019-04-12 13:23:37 (4388): Status Report: CPU Time: '22490.562500'
2019-04-12 13:56:52 (4388): Preference change detected
2019-04-12 13:56:52 (4388): Setting CPU throttle for VM. (100%)
2019-04-12 13:56:52 (4388): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds))
2019-04-12 14:00:22 (4388): Preference change detected
2019-04-12 14:00:22 (4388): Setting CPU throttle for VM. (100%)
2019-04-12 14:00:22 (4388): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds))
2019-04-12 14:14:17 (4388): Preference change detected
2019-04-12 14:14:17 (4388): Setting CPU throttle for VM. (100%)
2019-04-12 14:14:18 (4388): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds))
2019-04-12 15:03:41 (4388): Status Report: Elapsed Time: '18006.888784'
2019-04-12 15:03:41 (4388): Status Report: CPU Time: '34272.062500'
2019-04-12 16:43:45 (4388): Status Report: Elapsed Time: '24006.919891'
2019-04-12 16:43:45 (4388): Status Report: CPU Time: '46073.281250'
2019-04-12 18:23:47 (4388): Status Report: Elapsed Time: '30010.162891'
2019-04-12 18:23:47 (4388): Status Report: CPU Time: '57738.250000'
2019-04-12 18:35:53 (4388): Guest Log: The last 10 lines of the pilot log.

2019-04-12 18:35:53 (4388): Guest Log:     <metadata att_name="adler32" att_value="6e8d81bd"/>

2019-04-12 18:35:53 (4388): Guest Log:   </File>

2019-04-12 18:35:53 (4388): Guest Log: </POOLFILECATALOG>

2019-04-12 18:35:53 (4388): Guest Log: 2019-04-12 17:35:49 UTC [wrapper] ---------

2019-04-12 18:35:53 (4388): Guest Log: 2019-04-12 17:35:49 UTC [wrapper] output list

2019-04-12 18:35:53 (4388): Guest Log: HITS.17669023._009200.pool.root.1 srm://srm.ndgf.org:8443;autodir=no;spacetoken=ATLASDATADISK/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/0a/22/HITS.17669023._009200.pool.root.1:checksumtype=adler32:checksumvalue=6e8d81bd

2019-04-12 18:35:53 (4388): Guest Log: log.17669023._009200.job.log.tgz.1 srm://srm.ndgf.org:8443;autodir=no;spacetoken=ATLASDATADISK/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/f2/8a/log.17669023._009200.job.log.tgz.1:checksumtype=adler32:checksumvalue=7fef080b

2019-04-12 18:35:53 (4388): Guest Log: 2019-04-12 17:35:49 UTC [wrapper] ==== wrapper stdout END ====

2019-04-12 18:35:53 (4388): Guest Log: 2019-04-12 17:35:49 UTC [wrapper] ==== wrapper stderr END ====

2019-04-12 18:35:53 (4388): Guest Log: Listing of results directory

2019-04-12 18:35:53 (4388): Guest Log: total 499212

2019-04-12 18:35:53 (4388): Guest Log: -rw-r--r-- 1 atlas01 atlas01   1064884 Apr 10 14:08 pilotcode.tar.gz

2019-04-12 18:35:53 (4388): Guest Log: -rwx------ 1 atlas01 atlas01     15214 Apr 12 00:59 runpilot3-wrapper.sh

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01      2885 Apr 12 00:59 pandaJobData.out

2019-04-12 18:35:53 (4388): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 379274020 Apr 12 11:05 EVNT.16926640._000185.pool.root.1

2019-04-12 18:35:53 (4388): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     10343 Apr 12 11:05 init_data.xml

2019-04-12 18:35:53 (4388): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   1073474 Apr 12 11:05 input.tar.gz

2019-04-12 18:35:53 (4388): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       786 Apr 12 11:05 RTE.tar.gz

2019-04-12 18:35:53 (4388): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8644 Apr 12 11:05 start_atlas.sh

2019-04-12 18:35:53 (4388): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Apr 12 11:05 APPS

2019-04-12 18:35:53 (4388): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        16 Apr 12 11:06 RunJob.py -> pilot3/RunJob.py

2019-04-12 18:35:53 (4388): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        21 Apr 12 11:06 RunJobEvent.py -> pilot3/RunJobEvent.py

2019-04-12 18:35:53 (4388): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        16 Apr 12 11:06 VmPeak.py -> pilot3/VmPeak.py

2019-04-12 18:35:53 (4388): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        19 Apr 12 11:06 PILOTVERSION -> pilot3/PILOTVERSION

2019-04-12 18:35:53 (4388): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        15 Apr 12 11:06 pilot.py -> pilot3/pilot.py

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01        22 Apr 12 11:06 PILOT_INITDIR

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01        50 Apr 12 11:07 CURRENT_SITEWORKDIR

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01     11465 Apr 12 11:07 pilotlog.txt

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01         1 Apr 12 11:07 STATUSCODE

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01        11 Apr 12 11:07 pandaIDs.out

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01        19 Apr 12 11:07 START_TIME_4306264472

2019-04-12 18:35:53 (4388): Guest Log: -rw-r--r-- 1 atlas01 atlas01      3809 Apr 12 11:07 queuedata.json

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01      2885 Apr 12 11:07 pandaJobData_1.out

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01 110861157 Apr 12 19:32 HITS.17669023._009200.pool.root.1

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01       305 Apr 12 19:32 memory_monitor_summary.json

2019-04-12 18:35:53 (4388): Guest Log: drwx------ 6 atlas01 atlas01     12288 Apr 12 19:33 pilot3

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01   4833774 Apr 12 19:33 agis_schedconf.cvmfs.json

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01   7210745 Apr 12 19:33 agis_ddmendpoints.cvmfs.json

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01      1007 Apr 12 19:33 workdir_size-4306264472.json

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01    704146 Apr 12 19:33 log.17669023._009200.job.log.tgz.1

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01       924 Apr 12 19:33 OutputFiles-4306264472.xml

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01      1024 Apr 12 19:34 metadata-surl.xml

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01     67573 Apr 12 19:34 panda_node_struct.pickle

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01       137 Apr 12 19:35 pilotlog-last.txt

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01      7963 Apr 12 19:35 jobSmallFiles.tgz

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01   1726398 Apr 12 19:35 log.17669023._009200.job.log.1

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01       511 Apr 12 19:35 8v3MDm0pxYunShfckohDCDFpABFKDmABFKDmlDvKDmABFKDmihTGwn.diag

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01       463 Apr 12 19:35 output.list

2019-04-12 18:35:53 (4388): Guest Log: -rw-r--r-- 1 atlas01 atlas01      7397 Apr 12 19:35 runtime_log.err

2019-04-12 18:35:53 (4388): Guest Log: -rw-r--r-- 1 atlas01 atlas01       712 Apr 12 19:35 runtime_log

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01   4177920 Apr 12 19:35 result.tar.gz

2019-04-12 18:35:53 (4388): Guest Log: HITS file was successfully produced

2019-04-12 18:35:53 (4388): Guest Log: -rw------- 1 atlas01 atlas01 110861157 Apr 12 19:32 /home/atlas01/RunAtlas/HITS.17669023._009200.pool.root.1

2019-04-12 18:35:53 (4388): Guest Log: Successfully finished the ATLAS job!

2019-04-12 18:35:53 (4388): Guest Log: Copying the results back to the shared directory!

2019-04-12 18:35:53 (4388): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-04-12 18:35:53 (4388): Guest Log: Success! Shutting down the machine.

2019-04-12 18:35:53 (4388): VM Completion File Detected.
2019-04-12 18:35:53 (4388): Powering off VM.
2019-04-12 18:35:55 (4388): Successfully stopped VM.
2019-04-12 18:35:55 (4388): Deregistering VM. (boinc_3eb817bca1173600, slot#2)
2019-04-12 18:35:55 (4388): Removing network bandwidth throttle group from VM.
2019-04-12 18:35:55 (4388): Removing VM from VirtualBox.
18:36:00 (4388): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN