Name | cSlKDmXhXYunShfckohDCDFpABFKDmABFKDmTsnbDmABFKDmEoDNqm_1 |
Workunit | 1888404 |
Created | 10 Apr 2019, 21:33:16 UTC |
Sent | 10 Apr 2019, 23:12:59 UTC |
Report deadline | 17 Apr 2019, 23:12:59 UTC |
Received | 11 Apr 2019, 0:30:41 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 1113 |
Run time | 1 hours 15 min 0 sec |
CPU time | 10 min 1 sec |
Validate state | Valid |
Credit | 480.62 |
Device peak FLOPS | 13.30 GFLOPS |
Application version | ATLAS Simulation v0.60 (vbox64_mt_mcore_atlas) windows_x86_64 |
Peak working set size | 117.70 MB |
Peak swap size | 155.34 MB |
Peak disk usage | 1.98 GB |
<core_client_version>7.14.2</core_client_version> <![CDATA[ <stderr_txt> 2019-04-11 01:15:27 (46796): vboxwrapper (7.9.26200): starting 2019-04-11 01:15:27 (46796): Feature: Checkpoint interval offset (398 seconds) 2019-04-11 01:15:27 (46796): Detected: VirtualBox COM Interface (Version: 5.2.18) 2019-04-11 01:15:27 (46796): Detected: Minimum checkpoint interval (900.000000 seconds) 2019-04-11 01:15:27 (46796): Successfully copied 'init_data.xml' to the shared directory. 2019-04-11 01:15:27 (46796): Create VM. (boinc_fdc4bc7f29b7f2e5, slot#7) 2019-04-11 01:15:37 (46796): Setting Memory Size for VM. (6600MB) 2019-04-11 01:15:37 (46796): Setting CPU Count for VM. (4) 2019-04-11 01:15:37 (46796): Setting Chipset Options for VM. 2019-04-11 01:15:37 (46796): Setting Boot Options for VM. 2019-04-11 01:15:37 (46796): Enabling VM Network Access. 2019-04-11 01:15:37 (46796): Setting Network Configuration for NAT. 2019-04-11 01:15:37 (46796): Disabling USB Support for VM. 2019-04-11 01:15:37 (46796): Disabling COM Port Support for VM. 2019-04-11 01:15:37 (46796): Disabling LPT Port Support for VM. 2019-04-11 01:15:37 (46796): Disabling Audio Support for VM. 2019-04-11 01:15:37 (46796): Disabling Clipboard Support for VM. 2019-04-11 01:15:37 (46796): Disabling Drag and Drop Support for VM. 2019-04-11 01:15:37 (46796): Adding storage controller(s) to VM. 2019-04-11 01:15:37 (46796): Adding virtual disk drive to VM. (vm_image.vdi) 2019-04-11 01:15:40 (46796): Adding VirtualBox Guest Additions to VM. 2019-04-11 01:15:40 (46796): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-04-11 01:15:40 (46796): forwarding host port 10058 to guest port 80 2019-04-11 01:15:40 (46796): Enabling remote desktop for VM. 2019-04-11 01:15:40 (46796): Enabling shared directory for VM. 2019-04-11 01:15:41 (46796): Starting VM. (boinc_fdc4bc7f29b7f2e5, slot#7) 2019-04-11 01:15:53 (46796): Guest Log: BIOS: VirtualBox 5.2.18 2019-04-11 01:15:53 (46796): Guest Log: CPUID EDX: 0x178bfbff 2019-04-11 01:15:53 (46796): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-04-11 01:15:53 (46796): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-04-11 01:15:53 (46796): Guest Log: BIOS: Booting from Hard Disk... 2019-04-11 01:15:53 (46796): Successfully started VM. (PID = '44048') 2019-04-11 01:15:53 (46796): Reporting VM Process ID to BOINC. 2019-04-11 01:15:58 (46796): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-04-11 01:15:58 (46796): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-04-11 01:15:59 (46796): VM state change detected. (old = 'poweroff', new = 'running') 2019-04-11 01:16:04 (46796): Detected: Web Application Enabled (http://localhost:10058) 2019-04-11 01:16:04 (46796): Detected: Remote Desktop Enabled (localhost:10059) 2019-04-11 01:16:09 (46796): Preference change detected 2019-04-11 01:16:09 (46796): Setting CPU throttle for VM. (100%) 2019-04-11 01:16:09 (46796): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 900 seconds)) 2019-04-11 01:16:24 (46796): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-04-11 01:16:34 (46796): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801ae4e7c10), OR(0x0), NOT(0xffffffff), flags(0x0) 2019-04-11 01:16:34 (46796): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801aba22010), OR(0x0), NOT(0xffffffff), flags(0x0) 2019-04-11 01:16:34 (46796): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801aba22810), OR(0x0), NOT(0xffffffff), flags(0x0) 2019-04-11 01:16:34 (46796): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff8801aecb0e10), OR(0x0), NOT(0xffffffff), flags(0x0) 2019-04-11 01:17:14 (46796): Guest Log: Copying input files into RunAtlas. 2019-04-11 01:17:24 (46796): Guest Log: Copied input files into RunAtlas. 2019-04-11 01:17:49 (46796): Guest Log: copied the webapp to /var/www 2019-04-11 01:17:49 (46796): Guest Log: set up http_proxy http://192.168.200.1:0 2019-04-11 01:17:49 (46796): Guest Log: ATHENA_PROC_NUMBER=4 2019-04-11 01:17:49 (46796): Guest Log: Starting ATLAS job. ( ) 2019-04-11 02:30:08 (46796): Guest Log: log_extracts: 2019-04-11 02:30:13 (46796): Guest Log: - Last 10 lines from /home/atlas01/RunAtlas/Panda_Pilot_7864_1554938403/PandaJob/athena_stdout.txt - 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.trfExe.preExecute 2019-04-11 01:23:26,805 INFO Batch/grid running - command outputs will not be echoed. Logs for EVNTtoHITS are in log.EVNTtoHITS 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.trfExe.preExecute 2019-04-11 01:23:26,805 INFO Now writing wrapper for substep executor EVNTtoHITS 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.trfExe._writeAthenaWrapper 2019-04-11 01:23:26,805 INFO Valgrind not engaged 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.trfExe.preExecute 2019-04-11 01:23:26,805 INFO Athena will be executed in a subshell via ['./runwrapper.EVNTtoHITS.sh'] 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.trfExe.execute 2019-04-11 01:23:26,805 INFO Starting execution of EVNTtoHITS (['./runwrapper.EVNTtoHITS.sh']) 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.trfExe.execute 2019-04-11 02:27:28,654 INFO EVNTtoHITS executor returns 33 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.trfExe.validate 2019-04-11 02:27:29,766 ERROR Validation of return code failed: Non-zero return code from EVNTtoHITS (33) (Error code 65) 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.trfExe.validate 2019-04-11 02:27:29,804 INFO Scanning logfile log.EVNTtoHITS for errors 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.transform.execute 2019-04-11 02:27:29,849 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" 2019-04-11 02:30:13 (46796): Guest Log: PyJobTransforms.transform.execute 2019-04-11 02:27:33,146 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") 2019-04-11 02:30:13 (46796): Guest Log: - Walltime - 2019-04-11 02:30:13 (46796): Guest Log: JobRetrival=1, StageIn=15, Execution=3980, StageOut=0, CleanUp=19 2019-04-11 02:30:13 (46796): Guest Log: The last 10 lines of the pilot log. 2019-04-11 02:30:13 (46796): Guest Log: <metadata att_name="surl" att_value="srm://srm.ndgf.org:8443/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/f4/ba/log.17669023._003857.job.log.tgz.1"/> 2019-04-11 02:30:13 (46796): Guest Log: <metadata att_name="fsize" att_value="80255"/> 2019-04-11 02:30:13 (46796): Guest Log: <metadata att_name="adler32" att_value="6d30dd08"/> 2019-04-11 02:30:13 (46796): Guest Log: </File> 2019-04-11 02:30:13 (46796): Guest Log: </POOLFILECATALOG> 2019-04-11 02:30:13 (46796): Guest Log: 2019-04-11 00:30:08 UTC [wrapper] --------- 2019-04-11 02:30:13 (46796): Guest Log: 2019-04-11 00:30:08 UTC [wrapper] output list 2019-04-11 02:30:13 (46796): Guest Log: log.17669023._003857.job.log.tgz.1 srm://srm.ndgf.org:8443;autodir=no;spacetoken=ATLASDATADISK/srm/managerv2?SFN=/atlas/disk/atlasdatadisk/rucio/mc16_13TeV/f4/ba/log.17669023._003857.job.log.tgz.1:checksumtype=adler32:checksumvalue=6d30dd08 2019-04-11 02:30:13 (46796): Guest Log: 2019-04-11 00:30:08 UTC [wrapper] ==== wrapper stdout END ==== 2019-04-11 02:30:13 (46796): Guest Log: 2019-04-11 00:30:08 UTC [wrapper] ==== wrapper stderr END ==== 2019-04-11 02:30:13 (46796): Guest Log: Listing of results directory 2019-04-11 02:30:13 (46796): Guest Log: total 379088 2019-04-11 02:30:13 (46796): Guest Log: -rw-r--r-- 1 atlas01 atlas01 1064884 Apr 10 14:08 pilotcode.tar.gz 2019-04-11 02:30:13 (46796): Guest Log: -rwx------ 1 atlas01 atlas01 15214 Apr 10 21:04 runpilot3-wrapper.sh 2019-04-11 02:30:13 (46796): Guest Log: -rw------- 1 atlas01 atlas01 2883 Apr 10 21:04 pandaJobData.out 2019-04-11 02:30:13 (46796): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 372538839 Apr 11 01:17 EVNT.16926640._000078.pool.root.1 2019-04-11 02:30:14 (46796): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 10353 Apr 11 01:17 init_data.xml 2019-04-11 02:30:14 (46796): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 1073479 Apr 11 01:17 input.tar.gz 2019-04-11 02:30:14 (46796): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 786 Apr 11 01:17 RTE.tar.gz 2019-04-11 02:30:14 (46796): Guest Log: -rwxr-xr-x 1 atlas01 atlas01 8644 Apr 11 01:17 start_atlas.sh 2019-04-11 02:30:14 (46796): Guest Log: drwxr-xr-x 3 atlas01 atlas01 4096 Apr 11 01:17 APPS 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 243 Apr 11 01:17 setup.sh.local 2019-04-11 02:30:14 (46796): Guest Log: lrwxrwxrwx 1 atlas01 atlas01 16 Apr 11 01:18 RunJob.py -> pilot3/RunJob.py 2019-04-11 02:30:14 (46796): Guest Log: lrwxrwxrwx 1 atlas01 atlas01 21 Apr 11 01:18 RunJobEvent.py -> pilot3/RunJobEvent.py 2019-04-11 02:30:14 (46796): Guest Log: lrwxrwxrwx 1 atlas01 atlas01 16 Apr 11 01:18 VmPeak.py -> pilot3/VmPeak.py 2019-04-11 02:30:14 (46796): Guest Log: lrwxrwxrwx 1 atlas01 atlas01 19 Apr 11 01:18 PILOTVERSION -> pilot3/PILOTVERSION 2019-04-11 02:30:14 (46796): Guest Log: lrwxrwxrwx 1 atlas01 atlas01 15 Apr 11 01:18 pilot.py -> pilot3/pilot.py 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 22 Apr 11 01:18 PILOT_INITDIR 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 50 Apr 11 01:20 CURRENT_SITEWORKDIR 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 11465 Apr 11 01:20 pilotlog.txt 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 1 Apr 11 01:20 STATUSCODE 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 11 Apr 11 01:20 pandaIDs.out 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 19 Apr 11 01:20 START_TIME_4304613752 2019-04-11 02:30:14 (46796): Guest Log: -rw-r--r-- 1 atlas01 atlas01 3809 Apr 11 01:20 queuedata.json 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 2883 Apr 11 01:20 pandaJobData_1.out 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 7210745 Apr 11 01:21 agis_ddmendpoints.cvmfs.json 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 4829003 Apr 11 01:21 agis_schedconf.cvmfs.json 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 297 Apr 11 02:27 memory_monitor_summary.json 2019-04-11 02:30:14 (46796): Guest Log: drwx------ 6 atlas01 atlas01 12288 Apr 11 02:27 pilot3 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 203 Apr 11 02:27 pilot_error_report.json 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 166 Apr 11 02:28 workdir_size-4304613752.json 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 80255 Apr 11 02:28 log.17669023._003857.job.log.tgz.1 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 1757 Apr 11 02:28 log_extracts.txt 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 10477 Apr 11 02:28 panda_node_struct.pickle 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 137 Apr 11 02:30 pilotlog-last.txt 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 598 Apr 11 02:30 metadata-surl.xml 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 3865 Apr 11 02:30 jobSmallFiles.tgz 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 365239 Apr 11 02:30 log.17669023._003857.job.log.1 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 489 Apr 11 02:30 cSlKDmXhXYunShfckohDCDFpABFKDmABFKDmTsnbDmABFKDmEoDNqm.diag 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 241 Apr 11 02:30 output.list 2019-04-11 02:30:14 (46796): Guest Log: -rw-r--r-- 1 atlas01 atlas01 7869 Apr 11 02:30 runtime_log.err 2019-04-11 02:30:14 (46796): Guest Log: -rw-r--r-- 1 atlas01 atlas01 712 Apr 11 02:30 runtime_log 2019-04-11 02:30:14 (46796): Guest Log: -rw------- 1 atlas01 atlas01 829440 Apr 11 02:30 result.tar.gz 2019-04-11 02:30:14 (46796): Guest Log: No HITS file was produced 2019-04-11 02:30:14 (46796): Guest Log: Successfully finished the ATLAS job! 2019-04-11 02:30:14 (46796): Guest Log: Copying the results back to the shared directory! 2019-04-11 02:30:14 (46796): Guest Log: Copied the result file back to the shared directory and created atlas_done file! 2019-04-11 02:30:14 (46796): Guest Log: Success! Shutting down the machine. 2019-04-11 02:30:14 (46796): VM Completion File Detected. 2019-04-11 02:30:14 (46796): Powering off VM. 2019-04-11 02:30:15 (46796): Successfully stopped VM. 2019-04-11 02:30:20 (46796): Deregistering VM. (boinc_fdc4bc7f29b7f2e5, slot#7) 2019-04-11 02:30:20 (46796): Removing virtual disk drive(s) from VM. 2019-04-11 02:30:20 (46796): Removing network bandwidth throttle group from VM. 2019-04-11 02:30:20 (46796): Removing storage controller(s) from VM. 2019-04-11 02:30:21 (46796): Removing VM from VirtualBox. 02:30:26 (46796): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN