Name | eOyMDmR6BkvnShfckohDCDFpABFKDmABFKDmyiALDmdBFKDm8SVjvn_0 |
Workunit | 1948248 |
Created | 30 Oct 2019, 22:59:03 UTC |
Sent | 2 Nov 2019, 23:13:27 UTC |
Report deadline | 9 Nov 2019, 23:13:27 UTC |
Received | 3 Nov 2019, 6:43:13 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 282 |
Run time | 3 hours 7 min 11 sec |
CPU time | 1 hours 37 min 27 sec |
Validate state | Valid |
Credit | 64.98 |
Device peak FLOPS | 2.50 GFLOPS |
Application version | ATLAS Simulation v0.86 (vbox64_mt_mcore_atlas) windows_x86_64 |
Peak working set size | 99.10 MB |
Peak swap size | 135.07 MB |
Peak disk usage | 3.71 GB |
<core_client_version>7.14.2</core_client_version> <![CDATA[ <stderr_txt> 2019-11-03 02:04:41 (9676): Detected: vboxwrapper 26197 2019-11-03 02:04:41 (9676): Detected: BOINC client v7.7 2019-11-03 02:04:42 (9676): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2019-11-03 02:04:42 (9676): Successfully copied 'init_data.xml' to the shared directory. 2019-11-03 02:04:43 (9676): Create VM. (boinc_41fa5409bc9bd521, slot#0) 2019-11-03 02:04:44 (9676): Setting Memory Size for VM. (3900MB) 2019-11-03 02:04:44 (9676): Setting CPU Count for VM. (1) 2019-11-03 02:04:44 (9676): Setting Chipset Options for VM. 2019-11-03 02:04:45 (9676): Setting Boot Options for VM. 2019-11-03 02:04:45 (9676): Setting Network Configuration for NAT. 2019-11-03 02:04:45 (9676): Enabling VM Network Access. 2019-11-03 02:04:46 (9676): Disabling USB Support for VM. 2019-11-03 02:04:46 (9676): Disabling COM Port Support for VM. 2019-11-03 02:04:46 (9676): Disabling LPT Port Support for VM. 2019-11-03 02:04:46 (9676): Disabling Audio Support for VM. 2019-11-03 02:04:47 (9676): Disabling Clipboard Support for VM. 2019-11-03 02:04:47 (9676): Disabling Drag and Drop Support for VM. 2019-11-03 02:04:47 (9676): Adding storage controller(s) to VM. 2019-11-03 02:04:47 (9676): Adding virtual disk drive to VM. (vm_image.vdi) 2019-11-03 02:04:48 (9676): Adding VirtualBox Guest Additions to VM. 2019-11-03 02:04:48 (9676): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-11-03 02:04:48 (9676): forwarding host port 62956 to guest port 80 2019-11-03 02:04:49 (9676): Enabling remote desktop for VM. 2019-11-03 02:04:49 (9676): Enabling shared directory for VM. 2019-11-03 02:04:49 (9676): Starting VM using VBoxManage interface. (boinc_41fa5409bc9bd521, slot#0) 2019-11-03 02:04:59 (9676): Successfully started VM. (PID = '8936') 2019-11-03 02:04:59 (9676): Reporting VM Process ID to BOINC. 2019-11-03 02:04:59 (9676): Guest Log: BIOS: VirtualBox 6.0.14 2019-11-03 02:04:59 (9676): Guest Log: CPUID EDX: 0x178bfbff 2019-11-03 02:04:59 (9676): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-03 02:04:59 (9676): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-03 02:04:59 (9676): Detected: Web Application Enabled (http://localhost:62956) 2019-11-03 02:04:59 (9676): Detected: Remote Desktop Enabled (localhost:62957) 2019-11-03 02:04:59 (9676): Preference change detected 2019-11-03 02:04:59 (9676): Setting CPU throttle for VM. (100%) 2019-11-03 02:05:00 (9676): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 900 seconds)) 2019-11-03 02:05:01 (9676): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-03 02:05:01 (9676): Guest Log: BIOS: Booting from Hard Disk... 2019-11-03 02:05:04 (9676): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-03 02:05:04 (9676): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2019-11-03 02:05:04 (9676): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2019-11-03 02:05:14 (9676): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-03 02:05:14 (9676): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-03 02:05:26 (9676): Guest Log: Checking CVMFS... 2019-11-03 02:05:47 (9676): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2019-11-03 02:05:47 (9676): Guest Log: 00:00:00.002730 main Log opened 2019-11-03T02:05:45.310727000Z 2019-11-03 02:05:47 (9676): Guest Log: 00:00:00.003038 main OS Product: Linux 2019-11-03 02:05:47 (9676): Guest Log: 00:00:00.003202 main OS Release: 3.10.0-957.27.2.el7.x86_64 2019-11-03 02:05:47 (9676): Guest Log: 00:00:00.003339 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2019-11-03 02:05:47 (9676): Guest Log: 00:00:00.003492 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2019-11-03 02:05:47 (9676): Guest Log: 00:00:00.003495 main Process ID: 1541 2019-11-03 02:05:47 (9676): Guest Log: 00:00:00.003496 main Package type: LINUX_64BITS_GENERIC 2019-11-03 02:05:47 (9676): Guest Log: 00:00:00.009599 main 5.2.32 r132073 started. Verbose level = 0 2019-11-03 02:05:51 (9676): Guest Log: CVMFS is ok 2019-11-03 02:05:52 (9676): Guest Log: Mounting shared directory 2019-11-03 02:05:52 (9676): Guest Log: Copying input files 2019-11-03 02:05:57 (9676): Guest Log: Copied input files into RunAtlas. 2019-11-03 02:06:01 (9676): Guest Log: copied the webapp to /var/www 2019-11-03 02:06:01 (9676): Guest Log: This vm does not need to setup an http proxy 2019-11-03 02:06:01 (9676): Guest Log: core_number=1 2019-11-03 02:06:07 (9676): Guest Log: *** Starting ATLAS job. (PandaID=4002876565 taskID=000649-1) *** 2019-11-03 03:46:08 (9676): Status Report: Elapsed Time: '6000.335754' 2019-11-03 03:46:12 (9676): Status Report: CPU Time: '2968.140625' 2019-11-03 05:37:27 (9676): Error in pause VM for VM: -182 Command: VBoxManage -q controlvm "boinc_41fa5409bc9bd521" pause Output: 2019-11-03 05:37:32 (9676): Guest Log: *** Job finished *** 2019-11-03 05:37:32 (9676): Guest Log: *** The last 20 lines of the pilot log: *** 2019-11-03 05:37:32 (9676): Guest Log: 2019-11-03 05:28:19 UTC [wrapper] apfmon messages muted 2019-11-03 05:37:32 (9676): Guest Log: ---- find pandaID.out ---- 2019-11-03 05:37:32 (9676): Guest Log: total 60 2019-11-03 05:37:32 (9676): Guest Log: -rw-------. 1 atlas atlas 11357 Jul 25 14:38 LICENSE 2019-11-03 05:37:32 (9676): Guest Log: -rw-------. 1 atlas atlas 20 Sep 9 11:04 MANIFEST.IN 2019-11-03 05:37:32 (9676): Guest Log: -rw-------. 1 atlas atlas 11 Nov 3 02:06 pandaIDs.out 2019-11-03 05:37:32 (9676): Guest Log: drwx------. 14 atlas atlas 216 Nov 3 02:06 pilot 2019-11-03 05:37:32 (9676): Guest Log: -rwx------. 1 atlas atlas 20591 Oct 21 09:01 pilot.py 2019-11-03 05:37:32 (9676): Guest Log: -rw-------. 1 atlas atlas 7 Oct 22 15:22 PILOTVERSION 2019-11-03 05:37:32 (9676): Guest Log: -rw-------. 1 atlas atlas 2251 Jul 25 14:38 README.md 2019-11-03 05:37:32 (9676): Guest Log: -rw-------. 1 atlas atlas 766 Oct 10 14:01 setup.py 2019-11-03 05:37:32 (9676): Guest Log: -rw-------. 1 atlas atlas 221 Jul 25 14:38 TODO.md 2019-11-03 05:37:32 (9676): Guest Log: -rw-------. 1 atlas atlas 11 Nov 3 02:06 /home/atlas/RunAtlas/pilot2/pandaIDs.out 2019-11-03 05:37:32 (9676): Guest Log: 4002876565 2019-11-03 05:37:32 (9676): Guest Log: 2019-11-03 05:28:20 UTC [wrapper] Test setup, not cleaning 2019-11-03 05:37:32 (9676): Guest Log: 2019-11-03 05:28:20 UTC [wrapper] ==== wrapper stdout END ==== 2019-11-03 05:37:32 (9676): Guest Log: 2019-11-03 05:28:20 UTC [wrapper] ==== wrapper stderr END ==== 2019-11-03 05:37:32 (9676): Guest Log: 2019-11-03 05:28:20 UTC [wrapper] wrapper wrapperexiting ec=0, duration=12135 2019-11-03 05:37:32 (9676): Guest Log: 2019-11-03 05:28:20 UTC [wrapper] apfmon messages muted 2019-11-03 05:37:32 (9676): Guest Log: *** Error codes and diagnostics *** 2019-11-03 05:37:32 (9676): Guest Log: "exeErrorCode": 0, 2019-11-03 05:37:32 (9676): Guest Log: "exeErrorDiag": "", 2019-11-03 05:37:32 (9676): Guest Log: "pilotErrorCode": 0, 2019-11-03 05:37:32 (9676): Guest Log: "pilotErrorDiag": "", 2019-11-03 05:37:33 (9676): Guest Log: *** Listing of results directory *** 2019-11-03 05:37:33 (9676): Guest Log: total 22596 2019-11-03 05:37:33 (9676): Guest Log: -rw-r--r--. 1 atlas atlas 260992 Oct 30 22:30 pilot2.tar.gz 2019-11-03 05:37:33 (9676): Guest Log: -rw-r--r--. 1 atlas atlas 4480 Oct 30 22:56 queuedata.json 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 2948 Oct 30 22:58 pandaJobData.out 2019-11-03 05:37:33 (9676): Guest Log: -rwx------. 1 atlas atlas 12641 Oct 30 22:58 runpilot2-wrapper.sh 2019-11-03 05:37:33 (9676): Guest Log: -rwxr-xr-x. 1 atlas atlas 5914 Nov 3 02:05 init_data.xml 2019-11-03 05:37:33 (9676): Guest Log: -rwxr-xr-x. 1 atlas atlas 268518 Nov 3 02:05 input.tar.gz 2019-11-03 05:37:33 (9676): Guest Log: -rwxr-xr-x. 1 atlas atlas 815 Nov 3 02:05 RTE.tar.gz 2019-11-03 05:37:33 (9676): Guest Log: -rwxr-xr-x. 1 atlas atlas 8465 Nov 3 02:05 start_atlas.sh 2019-11-03 05:37:33 (9676): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Nov 3 02:05 EVNT.14296418._001447.pool.root.1 -> /data/./ATLAS.root_0 2019-11-03 05:37:33 (9676): Guest Log: drwxr-xr-x. 3 atlas atlas 17 Nov 3 02:06 APPS 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 3767147 Nov 3 02:06 agis_schedconf.cvmfs.json 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 7676865 Nov 3 02:06 agis_ddmendpoints.json 2019-11-03 05:37:33 (9676): Guest Log: drwx------. 3 atlas atlas 229 Nov 3 02:06 pilot2 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 9312952 Nov 3 05:19 HITS.000649-1706448-4626._078090.pool.root.1 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 827 Nov 3 05:27 memory_monitor_summary.json 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 221677 Nov 3 05:27 log.000649-1706448-4626._078090.job.log.tgz.1 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 10019 Nov 3 05:28 heartbeat.json 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 7230 Nov 3 05:28 pilotlog.txt 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 636947 Nov 3 05:28 log.14568781._078090.job.log.1 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 494 Nov 3 05:28 eOyMDmR6BkvnShfckohDCDFpABFKDmABFKDmyiALDmdBFKDm8SVjvn.diag 2019-11-03 05:37:33 (9676): Guest Log: -rw-r--r--. 1 atlas atlas 6797 Nov 3 05:28 runtime_log.err 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 496 Nov 3 05:28 output.list 2019-11-03 05:37:33 (9676): Guest Log: -rw-r--r--. 1 atlas atlas 717 Nov 3 05:28 runtime_log 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 880640 Nov 3 05:28 result.tar.gz 2019-11-03 05:37:33 (9676): Guest Log: Looking for outputfile HITS.000649-1706448-4626._078090.pool.root.1 2019-11-03 05:37:33 (9676): Guest Log: HITS file was successfully produced 2019-11-03 05:37:33 (9676): Guest Log: -rw-------. 1 atlas atlas 9312952 Nov 3 05:19 /home/atlas/RunAtlas/HITS.000649-1706448-4626._078090.pool.root.1 2019-11-03 05:37:33 (9676): Guest Log: Successfully finished the ATLAS job! 2019-11-03 05:37:33 (9676): Guest Log: Copying the results back to the shared directory! 2019-11-03 05:37:33 (9676): Guest Log: *** Contents of shared directory: *** 2019-11-03 05:37:33 (9676): Guest Log: total 366936 2019-11-03 05:37:33 (9676): Guest Log: -rwxrwxrwx. 1 root root 365251149 Nov 3 02:04 ATLAS.root_0 2019-11-03 05:37:33 (9676): Guest Log: -rwxrwxrwx. 1 root root 9312952 Nov 3 05:19 HITS.pool.root.1 2019-11-03 05:37:33 (9676): Guest Log: -rwxrwxrwx. 1 root root 5914 Nov 3 02:04 init_data.xml 2019-11-03 05:37:33 (9676): Guest Log: -rwxrwxrwx. 1 root root 268518 Nov 2 23:13 input.tar.gz 2019-11-03 05:37:33 (9676): Guest Log: -rwxrwxrwx. 1 root root 880640 Nov 3 05:29 result.tar.gz 2019-11-03 05:37:33 (9676): Guest Log: -rwxrwxrwx. 1 root root 815 Nov 2 23:13 RTE.tar.gz 2019-11-03 05:37:33 (9676): Guest Log: -rwxrwxrwx. 1 root root 8465 Nov 2 23:13 start_atlas.sh 2019-11-03 05:37:33 (9676): Guest Log: *** Success! Shutting down the machine. *** 2019-11-03 05:37:33 (9676): Guest Log: 03:24:50.735441 control Guest control service stopped 2019-11-03 05:37:33 (9676): Guest Log: 03:25:00.049860 main Error: Service 'control' failed to stop. (VERR_TIMEOUT) 2019-11-03 05:37:33 (9676): Guest Log: 03:25:00.050071 main Session 0 is about to close ... 2019-11-03 05:37:33 (9676): Guest Log: 03:25:00.050144 main Stopping all guest processes ... 2019-11-03 05:37:33 (9676): Guest Log: 03:25:00.050214 main Closing all guest files ... 2019-11-03 05:37:33 (9676): Guest Log: 03:25:00.540957 control Guest control worker returned with rc=VINF_SUCCESS 2019-11-03 05:37:33 (9676): Guest Log: 03:25:02.490790 main Ended. 2019-11-03 05:37:33 (9676): VM is no longer is a running state. It is in 'power off the VM has been issued (mMachineState=Stopping, InUninit=0) '. 2019-11-03 05:37:33 (9676): VM state change detected. (old = 'Running', new = 'power off the VM has been issued (mMachineState=Stopping, InUninit=0) ') 2019-11-03 05:37:33 (9676): VM Completion File Detected. 2019-11-03 05:37:33 (9676): Powering off VM. 2019-11-03 05:37:33 (9676): Deregistering VM. (boinc_41fa5409bc9bd521, slot#0) 2019-11-03 05:40:32 (9676): Removing network bandwidth throttle group from VM. 2019-11-03 05:40:53 (9676): Removing VM from VirtualBox. 05:41:06 (9676): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN