Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-04-13 13:20:08 (9040): vboxwrapper (7.9.26200): starting
2019-04-13 13:20:09 (9040): Feature: Checkpoint interval offset (541 seconds)
2019-04-13 13:20:09 (9040): Detected: VirtualBox VboxManage Interface (Version: 6.0.2)
2019-04-13 13:20:10 (9040): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-04-13 13:20:10 (9040): Successfully copied 'init_data.xml' to the shared directory.
2019-04-13 13:20:14 (9040): Create VM. (boinc_4ffadd0ebec1d3e8, slot#2)
2019-04-13 13:20:14 (9040): Setting Memory Size for VM. (4800MB)
2019-04-13 13:20:15 (9040): Setting CPU Count for VM. (2)
2019-04-13 13:20:15 (9040): Setting Chipset Options for VM.
2019-04-13 13:20:16 (9040): Setting Boot Options for VM.
2019-04-13 13:20:16 (9040): Setting Network Configuration for NAT.
2019-04-13 13:20:18 (9040): Enabling VM Network Access.
2019-04-13 13:20:19 (9040): Disabling USB Support for VM.
2019-04-13 13:20:20 (9040): Disabling COM Port Support for VM.
2019-04-13 13:20:20 (9040): Disabling LPT Port Support for VM.
2019-04-13 13:20:21 (9040): Disabling Audio Support for VM.
2019-04-13 13:20:23 (9040): Disabling Clipboard Support for VM.
2019-04-13 13:20:23 (9040): Disabling Drag and Drop Support for VM.
2019-04-13 13:20:24 (9040): Adding storage controller(s) to VM.
2019-04-13 13:20:25 (9040): Adding virtual disk drive to VM. (vm_image.vdi)
2019-04-13 13:20:25 (9040): Adding VirtualBox Guest Additions to VM.
2019-04-13 13:20:25 (9040): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-04-13 13:20:26 (9040): forwarding host port 50103 to guest port 80
2019-04-13 13:20:26 (9040): Enabling remote desktop for VM.
2019-04-13 13:20:27 (9040): Enabling shared directory for VM.
2019-04-13 13:20:28 (9040): Starting VM using VboxManage interface. (boinc_4ffadd0ebec1d3e8, slot#2)
2019-04-13 13:20:33 (9040): Successfully started VM. (PID = '7652')
2019-04-13 13:20:33 (9040): Reporting VM Process ID to BOINC.
2019-04-13 13:20:38 (9040): Guest Log: BIOS: VirtualBox 6.0.2

2019-04-13 13:20:38 (9040): Guest Log: CPUID EDX: 0x178bfbff

2019-04-13 13:20:38 (9040): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-04-13 13:20:38 (9040): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-04-13 13:20:38 (9040): Guest Log: BIOS: Booting from Hard Disk...

2019-04-13 13:20:38 (9040): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-04-13 13:20:38 (9040): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-04-13 13:20:39 (9040): VM state change detected. (old = 'poweroff', new = 'running')
2019-04-13 13:20:44 (9040): Detected: Web Application Enabled (http://localhost:50103)
2019-04-13 13:20:44 (9040): Detected: Remote Desktop Enabled (localhost:50105)
2019-04-13 13:20:50 (9040): Preference change detected
2019-04-13 13:20:50 (9040): Setting CPU throttle for VM. (100%)
2019-04-13 13:20:50 (9040): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds))
2019-04-13 13:20:56 (9040): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-04-13 13:21:01 (9040): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d87e410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-13 13:21:01 (9040): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d87a810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-13 13:21:01 (9040): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d87e610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-13 13:21:01 (9040): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d87a410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-13 13:22:14 (9040): Guest Log: Copying input files into RunAtlas.

2019-04-13 13:22:19 (9040): Guest Log: Copied input files into RunAtlas.

2019-04-13 13:22:36 (9040): Guest Log: copied the webapp to /var/www

2019-04-13 13:22:36 (9040): Guest Log: This vm does not need to setup http proxy

2019-04-13 13:22:36 (9040): Guest Log: ATHENA_PROC_NUMBER=2

2019-04-13 13:22:36 (9040): Guest Log: Starting ATLAS job. ( )

2019-04-13 15:00:57 (9040): Status Report: Elapsed Time: '6003.977062'
2019-04-13 15:00:57 (9040): Status Report: CPU Time: '10875.515625'
2019-04-13 16:41:00 (9040): Status Report: Elapsed Time: '12007.037369'
2019-04-13 16:41:00 (9040): Status Report: CPU Time: '22861.937500'
2019-04-13 17:21:07 (9040): Stopping VM.
2019-04-13 17:21:26 (9040): Successfully stopped VM.
2019-04-13 17:30:47 (7396): vboxwrapper (7.9.26200): starting
2019-04-13 17:30:48 (7396): Feature: Checkpoint interval offset (442 seconds)
2019-04-13 17:30:48 (7396): Detected: VirtualBox VboxManage Interface (Version: 6.0.2)
2019-04-13 17:30:48 (7396): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-04-13 17:30:48 (7396): Guest Log: BIOS: VirtualBox 6.0.2

2019-04-13 17:30:48 (7396): Guest Log: CPUID EDX: 0x178bfbff

2019-04-13 17:30:48 (7396): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-04-13 17:30:48 (7396): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-04-13 17:30:48 (7396): Guest Log: BIOS: Booting from Hard Disk...

2019-04-13 17:30:48 (7396): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-04-13 17:30:48 (7396): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-04-13 17:30:48 (7396): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-04-13 17:30:48 (7396): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d87e410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-13 17:30:48 (7396): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d87a810), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-13 17:30:48 (7396): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d87e610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-13 17:30:48 (7396): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d87a410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-04-13 17:30:48 (7396): Guest Log: Copying input files into RunAtlas.

2019-04-13 17:30:48 (7396): Guest Log: Copied input files into RunAtlas.

2019-04-13 17:30:48 (7396): Guest Log: copied the webapp to /var/www

2019-04-13 17:30:48 (7396): Guest Log: This vm does not need to setup http proxy

2019-04-13 17:30:48 (7396): Guest Log: ATHENA_PROC_NUMBER=2

2019-04-13 17:30:48 (7396): Guest Log: Starting ATLAS job. ( )

2019-04-13 17:30:48 (7396): Starting VM using VboxManage interface. (boinc_4ffadd0ebec1d3e8, slot#2)
2019-04-13 17:31:06 (7396): Successfully started VM. (PID = '5568')
2019-04-13 17:31:06 (7396): Reporting VM Process ID to BOINC.
2019-04-13 17:31:13 (7396): VM state change detected. (old = 'poweroff', new = 'running')
2019-04-13 17:31:18 (7396): Detected: Web Application Enabled (http://localhost:50103)
2019-04-13 17:31:18 (7396): Detected: Remote Desktop Enabled (localhost:50105)
2019-04-13 17:31:24 (7396): Status Report: Elapsed Time: '14415.627777'
2019-04-13 17:31:24 (7396): Status Report: CPU Time: '27435.937500'
2019-04-13 17:31:24 (7396): Preference change detected
2019-04-13 17:31:24 (7396): Setting CPU throttle for VM. (100%)
2019-04-13 17:31:24 (7396): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 900 seconds))
2019-04-13 17:36:32 (7396): Guest Log: The last 10 lines of the pilot log.

2019-04-13 17:36:32 (7396): Guest Log:     <metadata att_name="adler32" att_value="7575a99d"/>

2019-04-13 17:36:32 (7396): Guest Log:   </File>

2019-04-13 17:36:32 (7396): Guest Log: </POOLFILECATALOG>

2019-04-13 17:36:32 (7396): Guest Log: 2019-04-13 16:36:28 UTC [wrapper] ---------

2019-04-13 17:36:32 (7396): Guest Log: 2019-04-13 16:36:28 UTC [wrapper] output list

2019-04-13 17:36:32 (7396): Guest Log: HITS.17602216._050181.pool.root.1 srm://srm.ndgf.org:8443;autodir=no;spacetoken=ATLASDATADISK/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/c1/9c/HITS.17602216._050181.pool.root.1:checksumtype=adler32:checksumvalue=7575a99d

2019-04-13 17:36:32 (7396): Guest Log: log.17602216._050181.job.log.tgz.1 srm://srm.ndgf.org:8443;autodir=no;spacetoken=ATLASDATADISK/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/f4/12/log.17602216._050181.job.log.tgz.1:checksumtype=adler32:checksumvalue=0d525099

2019-04-13 17:36:32 (7396): Guest Log: 2019-04-13 16:36:28 UTC [wrapper] ==== wrapper stdout END ====

2019-04-13 17:36:32 (7396): Guest Log: 2019-04-13 16:36:28 UTC [wrapper] ==== wrapper stderr END ====

2019-04-13 17:36:32 (7396): Guest Log: Listing of results directory

2019-04-13 17:36:32 (7396): Guest Log: total 489976

2019-04-13 17:36:32 (7396): Guest Log: -rw-r--r-- 1 atlas01 atlas01   1089918 Apr  3 05:59 pilotcode.tar.gz

2019-04-13 17:36:32 (7396): Guest Log: -rwx------ 1 atlas01 atlas01     15214 Apr 10 11:10 runpilot3-wrapper.sh

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01      2886 Apr 10 11:10 pandaJobData.out

2019-04-13 17:36:32 (7396): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 373733026 Apr 13 14:22 EVNT.16926542._000999.pool.root.1

2019-04-13 17:36:32 (7396): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     10343 Apr 13 14:22 init_data.xml

2019-04-13 17:36:32 (7396): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   1098424 Apr 13 14:22 input.tar.gz

2019-04-13 17:36:32 (7396): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       786 Apr 13 14:22 RTE.tar.gz

2019-04-13 17:36:32 (7396): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8644 Apr 13 14:22 start_atlas.sh

2019-04-13 17:36:32 (7396): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Apr 13 14:22 APPS

2019-04-13 17:36:32 (7396): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        16 Apr 13 14:23 RunJob.py -> pilot3/RunJob.py

2019-04-13 17:36:32 (7396): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        21 Apr 13 14:23 RunJobEvent.py -> pilot3/RunJobEvent.py

2019-04-13 17:36:32 (7396): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        16 Apr 13 14:23 VmPeak.py -> pilot3/VmPeak.py

2019-04-13 17:36:32 (7396): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        19 Apr 13 14:23 PILOTVERSION -> pilot3/PILOTVERSION

2019-04-13 17:36:32 (7396): Guest Log: lrwxrwxrwx 1 atlas01 atlas01        15 Apr 13 14:23 pilot.py -> pilot3/pilot.py

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01        22 Apr 13 14:23 PILOT_INITDIR

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01        50 Apr 13 14:23 CURRENT_SITEWORKDIR

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01     11355 Apr 13 14:23 pilotlog.txt

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01         1 Apr 13 14:23 STATUSCODE

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01        11 Apr 13 14:23 pandaIDs.out

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01        19 Apr 13 14:23 START_TIME_4304387172

2019-04-13 17:36:32 (7396): Guest Log: -rw-r--r-- 1 atlas01 atlas01      3809 Apr 13 14:23 queuedata.json

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01      2886 Apr 13 14:23 pandaJobData_1.out

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01 109421215 Apr 13 18:34 HITS.17602216._050181.pool.root.1

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01       305 Apr 13 18:34 memory_monitor_summary.json

2019-04-13 17:36:32 (7396): Guest Log: drwx------ 6 atlas01 atlas01     12288 Apr 13 18:34 pilot3

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01   4834642 Apr 13 18:34 agis_schedconf.cvmfs.json

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01   7210745 Apr 13 18:34 agis_ddmendpoints.cvmfs.json

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01       527 Apr 13 18:34 workdir_size-4304387172.json

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01    623015 Apr 13 18:34 log.17602216._050181.job.log.tgz.1

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01       924 Apr 13 18:34 OutputFiles-4304387172.xml

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01      1024 Apr 13 18:35 metadata-surl.xml

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01     47455 Apr 13 18:35 panda_node_struct.pickle

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01       137 Apr 13 18:36 pilotlog-last.txt

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01      6633 Apr 13 18:36 jobSmallFiles.tgz

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01    950176 Apr 13 18:36 log.17602216._050181.job.log.1

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01       510 Apr 13 18:36 ZReKDmjQOYunShfckohDCDFpABFKDmABFKDmePYbDmABFKDmekmjnn.diag

2019-04-13 17:36:32 (7396): Guest Log: -rw-r--r-- 1 atlas01 atlas01      7331 Apr 13 18:36 runtime_log.err

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01       463 Apr 13 18:36 output.list

2019-04-13 17:36:32 (7396): Guest Log: -rw-r--r-- 1 atlas01 atlas01       712 Apr 13 18:36 runtime_log

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01   2539520 Apr 13 18:36 result.tar.gz

2019-04-13 17:36:32 (7396): Guest Log: HITS file was successfully produced

2019-04-13 17:36:32 (7396): Guest Log: -rw------- 1 atlas01 atlas01 109421215 Apr 13 18:34 /home/atlas01/RunAtlas/HITS.17602216._050181.pool.root.1

2019-04-13 17:36:32 (7396): Guest Log: Successfully finished the ATLAS job!

2019-04-13 17:36:32 (7396): Guest Log: Copying the results back to the shared directory!

2019-04-13 17:36:32 (7396): Guest Log: Copied the result file back to the shared directory and created atlas_done file!

2019-04-13 17:36:32 (7396): Guest Log: Success! Shutting down the machine.

2019-04-13 17:36:32 (7396): VM Completion File Detected.
2019-04-13 17:36:32 (7396): Powering off VM.
2019-04-13 17:36:33 (7396): Successfully stopped VM.
2019-04-13 17:36:33 (7396): Deregistering VM. (boinc_4ffadd0ebec1d3e8, slot#2)
2019-04-13 17:36:33 (7396): Removing network bandwidth throttle group from VM.
2019-04-13 17:36:34 (7396): Removing VM from VirtualBox.
17:36:39 (7396): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN