Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2018-12-28 06:20:56 (3852): vboxwrapper (7.7.26196): starting
2018-12-28 06:20:56 (3852): Error creating VirtualBox instance! rc = 0x80004002
2018-12-28 06:20:57 (3852): Feature: Checkpoint interval offset (396 seconds)
2018-12-28 06:20:57 (3852): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2018-12-28 06:20:57 (3852): Detected: Minimum checkpoint interval (900.000000 seconds)
2018-12-28 06:20:57 (3852): Successfully copied 'init_data.xml' to the shared directory.
2018-12-28 06:21:02 (3852): Create VM. (boinc_1434db9648bde68b, slot#1)
2018-12-28 06:21:03 (3852): Setting Memory Size for VM. (10200MB)
2018-12-28 06:21:04 (3852): Setting CPU Count for VM. (8)
2018-12-28 06:21:05 (3852): Setting Chipset Options for VM.
2018-12-28 06:21:05 (3852): Setting Boot Options for VM.
2018-12-28 06:21:05 (3852): Setting Network Configuration for NAT.
2018-12-28 06:21:06 (3852): Enabling VM Network Access.
2018-12-28 06:21:06 (3852): Disabling USB Support for VM.
2018-12-28 06:21:07 (3852): Disabling COM Port Support for VM.
2018-12-28 06:21:07 (3852): Disabling LPT Port Support for VM.
2018-12-28 06:21:08 (3852): Disabling Audio Support for VM.
2018-12-28 06:21:08 (3852): Disabling Clipboard Support for VM.
2018-12-28 06:21:09 (3852): Disabling Drag and Drop Support for VM.
2018-12-28 06:21:09 (3852): Adding storage controller(s) to VM.
2018-12-28 06:21:09 (3852): Adding virtual disk drive to VM. (vm_image.vdi)
2018-12-28 06:21:10 (3852): Adding VirtualBox Guest Additions to VM.
2018-12-28 06:21:11 (3852): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2018-12-28 06:21:11 (3852): forwarding host port 62111 to guest port 80
2018-12-28 06:21:12 (3852): Enabling remote desktop for VM.
2018-12-28 06:21:12 (3852): Required extension pack not installed, remote desktop not enabled.
2018-12-28 06:21:12 (3852): Enabling shared directory for VM.
2018-12-28 06:21:13 (3852): Starting VM. (boinc_1434db9648bde68b, slot#1)
2018-12-28 06:21:22 (3852): Successfully started VM. (PID = '11940')
2018-12-28 06:21:22 (3852): Reporting VM Process ID to BOINC.
2018-12-28 06:21:33 (3852): Guest Log: BIOS: VirtualBox 5.2.8
2018-12-28 06:21:33 (3852): Guest Log: CPUID EDX: 0x178bfbff
2018-12-28 06:21:33 (3852): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2018-12-28 06:21:33 (3852): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2018-12-28 06:21:33 (3852): Guest Log: BIOS: Booting from Hard Disk...
2018-12-28 06:21:33 (3852): Guest Log: BIOS: KBD: unsupported int 16h function 03
2018-12-28 06:21:33 (3852): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2018-12-28 06:21:33 (3852): VM state change detected. (old = 'poweroff', new = 'running')
2018-12-28 06:21:43 (3852): Detected: Web Application Enabled (http://localhost:62111)
2018-12-28 06:21:53 (3852): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2018-12-28 06:21:53 (3852): Preference change detected
2018-12-28 06:21:53 (3852): Setting CPU throttle for VM. (85%)
2018-12-28 06:21:53 (3852): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2018-12-28 06:22:04 (3852): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8802876fb410), OR(0x0), NOT(0xffffffff), flags(0x0)
2018-12-28 06:22:04 (3852): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880287713010), OR(0x0), NOT(0xffffffff), flags(0x0)
2018-12-28 06:22:04 (3852): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880287712410), OR(0x0), NOT(0xffffffff), flags(0x0)
2018-12-28 06:22:04 (3852): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880288e35c10), OR(0x0), NOT(0xffffffff), flags(0x0)
2018-12-28 06:23:26 (3852): Guest Log: Copying input files into RunAtlas.
2018-12-28 06:23:26 (3852): Guest Log: Copied input files into RunAtlas.
2018-12-28 06:23:57 (3852): Guest Log: copied the webapp to /var/www
2018-12-28 06:23:57 (3852): Guest Log: This vm does not need to setup http proxy
2018-12-28 06:23:57 (3852): Guest Log: ATHENA_PROC_NUMBER=8
2018-12-28 06:23:57 (3852): Guest Log: Starting ATLAS job. (PandaID=4192949760 taskID=16555277)
2018-12-28 06:31:09 (3852): Guest Log: log_extracts:
2018-12-28 06:31:09 (3852): Guest Log: - Last 10 lines from /home/atlas01/RunAtlas/Panda_Pilot_3601_1546007036/PandaJob/athena_stdout.txt -
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.trfExe.preExecute 2018-12-28 08:26:32,653 INFO Batch/grid running - command outputs will not be echoed. Logs for EVNTtoHITS are in log.EVNTtoHITS
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.trfExe.preExecute 2018-12-28 08:26:32,654 INFO Now writing wrapper for substep executor EVNTtoHITS
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.trfExe._writeAthenaWrapper 2018-12-28 08:26:32,654 INFO Valgrind not engaged
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.trfExe.preExecute 2018-12-28 08:26:32,655 INFO Athena will be executed in a subshell via ['./runwrapper.EVNTtoHITS.sh']
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.trfExe.execute 2018-12-28 08:26:32,655 INFO Starting execution of EVNTtoHITS (['./runwrapper.EVNTtoHITS.sh'])
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.trfExe.execute 2018-12-28 08:28:17,604 INFO EVNTtoHITS executor returns 33
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.trfExe.validate 2018-12-28 08:28:18,600 ERROR Validation of return code failed: Non-zero return code from EVNTtoHITS (33) (Error code 65)
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.trfExe.validate 2018-12-28 08:28:18,613 INFO Scanning logfile log.EVNTtoHITS for errors
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.transform.execute 2018-12-28 08:28:18,633 CRITICAL Transform executor raised TransformValidationException: Non-zero return code from EVNTtoHITS (33); Logfile error in log.EVNTtoHITS: "IOVDbSvc            FATAL Conditions database connection COOLOFL_TRT/OFLP200 cannot be opened - STOP"
2018-12-28 06:31:09 (3852): Guest Log: PyJobTransforms.transform.execute 2018-12-28 08:28:21,803 WARNING Transform now exiting early with exit code 65 (Non-zero return code from EVNTtoHITS (33); Logfile error in log.EVNTtoHITS: "IOVDbSvc            FATAL Conditions database connection COOLOFL_TRT/OFLP200 cannot be opened - STOP")
2018-12-28 06:31:09 (3852): Guest Log: - Walltime -
2018-12-28 06:31:09 (3852): Guest Log: JobRetrival=0, StageIn=10, Execution=162, StageOut=0, CleanUp=11
2018-12-28 06:31:09 (3852): Guest Log: The last 10 lines of the pilot log.
2018-12-28 06:31:09 (3852): Guest Log:       <lfn name="log.16555277._075816.job.log.tgz.1"/>
2018-12-28 06:31:09 (3852): Guest Log:     </logical>
2018-12-28 06:31:09 (3852): Guest Log:     <metadata att_name="surl" att_value="srm://srm.ndgf.org:8443/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/c3/5f/log.16555277._075816.job.log.tgz.1"/>
2018-12-28 06:31:09 (3852): Guest Log:     <metadata att_name="fsize" att_value="66228"/>
2018-12-28 06:31:09 (3852): Guest Log:     <metadata att_name="adler32" att_value="647682b8"/>
2018-12-28 06:31:09 (3852): Guest Log:   </File>
2018-12-28 06:31:09 (3852): Guest Log: </POOLFILECATALOG>
2018-12-28 06:31:09 (3852): Guest Log: ---------
2018-12-28 06:31:09 (3852): Guest Log: output list
2018-12-28 06:31:09 (3852): Guest Log: log.16555277._075816.job.log.tgz.1 srm://srm.ndgf.org:8443;autodir=no;spacetoken=ATLASDATADISK/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/c3/5f/log.16555277._075816.job.log.tgz.1:checksumtype=adler32:checksumvalue=647682b8
2018-12-28 06:31:09 (3852): Guest Log: No HITS file was produced
2018-12-28 06:31:09 (3852): Guest Log: total 200792
2018-12-28 06:31:09 (3852): Guest Log: -rw-r--r-- 1 atlas01 atlas01      4436 Dec 27 14:30 queuedata.pilot.json
2018-12-28 06:31:09 (3852): Guest Log: -rwx------ 1 atlas01 atlas01      2441 Dec 27 14:34 ARCpilot
2018-12-28 06:31:09 (3852): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 190785293 Dec 28 08:23 EVNT.12959107._001545.pool.root.1
2018-12-28 06:31:09 (3852): Guest Log: -rwxr-xr-x 1 atlas01 atlas01      8502 Dec 28 08:23 init_data.xml
2018-12-28 06:31:09 (3852): Guest Log: -rwxr-xr-x 1 atlas01 atlas01   1088718 Dec 28 08:23 input.tar.gz
2018-12-28 06:31:09 (3852): Guest Log: -rwxr-xr-x 1 atlas01 atlas01       605 Dec 28 08:23 RTE.tar.gz
2018-12-28 06:31:09 (3852): Guest Log: -rwxr-xr-x 1 atlas01 atlas01     14289 Dec 28 08:23 start_atlas.sh
2018-12-28 06:31:09 (3852): Guest Log: drwxr-xr-x 3 atlas01 atlas01      4096 Dec 28 08:23 APPS
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01      2925 Dec 28 08:23 pandaJobData.out
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01        22 Dec 28 08:23 PILOT_INITDIR
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01        50 Dec 28 08:24 CURRENT_SITEWORKDIR
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01     11430 Dec 28 08:24 pilotlog.txt
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01         1 Dec 28 08:24 STATUSCODE
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01        11 Dec 28 08:24 pandaIDs.out
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01        19 Dec 28 08:24 START_TIME_4192949760
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01      3801 Dec 28 08:24 queuedata.json
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01      2925 Dec 28 08:24 pandaJobData_1.out
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01   7158983 Dec 28 08:25 agis_ddmendpoints.cvmfs.json
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01   5694971 Dec 28 08:25 agis_schedconf.cvmfs.json
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01       302 Dec 28 08:28 memory_monitor_summary.json
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01       203 Dec 28 08:28 pilot_error_report.json
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01        46 Dec 28 08:29 workdir_size-4192949760.json
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01     66228 Dec 28 08:29 log.16555277._075816.job.log.tgz.1
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01       241 Dec 28 08:29 output.list
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01      1756 Dec 28 08:29 log_extracts.txt
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01     12146 Dec 28 08:29 panda_node_struct.pickle
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01       137 Dec 28 08:30 pilotlog-last.txt
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01       598 Dec 28 08:30 metadata-surl.xml
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01    182379 Dec 28 08:30 log.16555277._075816.job.log.1
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01      4160 Dec 28 08:30 jobSmallFiles.tgz
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01       482 Dec 28 08:30 4ACLDmVXrwtnyYickojUe11pABFKDmABFKDmFchPDmABFKDmnw8ykn.diag
2018-12-28 06:31:09 (3852): Guest Log: -rw-r--r-- 1 atlas01 atlas01      9989 Dec 28 08:30 runtime_log.err
2018-12-28 06:31:09 (3852): Guest Log: -rw-r--r-- 1 atlas01 atlas01       604 Dec 28 08:30 runtime_log
2018-12-28 06:31:09 (3852): Guest Log: -rw------- 1 atlas01 atlas01    450560 Dec 28 08:30 result.tar.gz
2018-12-28 06:31:09 (3852): Guest Log: Successfully finished the ATLAS job!
2018-12-28 06:31:09 (3852): Guest Log: Copying the results back to the shared directory!
2018-12-28 06:31:09 (3852): Guest Log: Copied the result file back to the shared directory and created atlas_done file!
2018-12-28 06:31:09 (3852): Guest Log: Success! Shutting down the machine.
2018-12-28 06:31:09 (3852): VM Completion File Detected.
2018-12-28 06:31:09 (3852): Powering off VM.
2018-12-28 06:31:10 (3852): Successfully stopped VM.
2018-12-28 06:31:10 (3852): Deregistering VM. (boinc_1434db9648bde68b, slot#1)
2018-12-28 06:31:10 (3852): Removing network bandwidth throttle group from VM.
2018-12-28 06:31:10 (3852): Removing storage controller(s) from VM.
2018-12-28 06:31:10 (3852): Removing VM from VirtualBox.
2018-12-28 06:31:10 (3852): Removing virtual disk drive from VirtualBox.
06:31:16 (3852): called boinc_finish(0)

</stderr_txt>
]]>

©2026 CERN