| Name | hw9KDm4I63zn7Olcko1bjSoqABFKDmABFKDmZr2WDmhCGKDmsbgSbn_0 |
| Workunit | 2141427 |
| Created | 7 Nov 2021, 22:59:09 UTC |
| Sent | 7 Nov 2021, 23:00:31 UTC |
| Report deadline | 14 Nov 2021, 23:00:31 UTC |
| Received | 23 Nov 2021, 16:58:33 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 400 |
| Run time | 12 days 20 hours 9 min 36 sec |
| CPU time | 4 hours 35 min 29 sec |
| Validate state | Valid |
| Credit | 5,471.73 |
| Device peak FLOPS | 4.08 GFLOPS |
| Application version | ATLAS Simulation v0.86 (vbox64_mt_mcore_atlas) windows_x86_64 |
| Peak working set size | 66.98 MB |
| Peak swap size | 87.03 MB |
| Peak disk usage | 3.30 GB |
Stderr output
<core_client_version>7.16.20</core_client_version> <![CDATA[ <stderr_txt> 2021-11-08 00:08:19 (18936): Detected: vboxwrapper 26197 2021-11-08 00:08:19 (18936): Detected: BOINC client v7.7 2021-11-08 00:08:20 (18936): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2021-11-08 00:08:20 (18936): Successfully copied 'init_data.xml' to the shared directory. 2021-11-08 00:08:21 (18936): Create VM. (boinc_d21395436dc8fe8c, slot#5) 2021-11-08 00:08:22 (18936): Setting Memory Size for VM. (4800MB) 2021-11-08 00:08:22 (18936): Setting CPU Count for VM. (2) 2021-11-08 00:08:22 (18936): Setting Chipset Options for VM. 2021-11-08 00:08:22 (18936): Setting Boot Options for VM. 2021-11-08 00:08:23 (18936): Setting Network Configuration for NAT. 2021-11-08 00:08:23 (18936): Enabling VM Network Access. 2021-11-08 00:08:23 (18936): Disabling USB Support for VM. 2021-11-08 00:08:24 (18936): Disabling COM Port Support for VM. 2021-11-08 00:08:24 (18936): Disabling LPT Port Support for VM. 2021-11-08 00:08:24 (18936): Disabling Audio Support for VM. 2021-11-08 00:08:24 (18936): Disabling Clipboard Support for VM. 2021-11-08 00:08:25 (18936): Disabling Drag and Drop Support for VM. 2021-11-08 00:08:25 (18936): Adding storage controller(s) to VM. 2021-11-08 00:08:25 (18936): Adding virtual disk drive to VM. (vm_image.vdi) 2021-11-08 00:08:25 (18936): Adding VirtualBox Guest Additions to VM. 2021-11-08 00:08:26 (18936): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2021-11-08 00:08:26 (18936): forwarding host port 58349 to guest port 80 2021-11-08 00:08:26 (18936): Enabling remote desktop for VM. 2021-11-08 00:08:27 (18936): Enabling shared directory for VM. 2021-11-08 00:08:27 (18936): Starting VM using VBoxManage interface. (boinc_d21395436dc8fe8c, slot#5) 2021-11-08 00:08:36 (18936): Successfully started VM. (PID = '19004') 2021-11-08 00:08:36 (18936): Reporting VM Process ID to BOINC. 2021-11-08 00:08:36 (18936): Guest Log: BIOS: VirtualBox 6.1.28 2021-11-08 00:08:36 (18936): Guest Log: CPUID EDX: 0x178bfbff 2021-11-08 00:08:36 (18936): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-11-08 00:08:36 (18936): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-11-08 00:08:36 (18936): Detected: Web Application Enabled (http://localhost:58349) 2021-11-08 00:08:36 (18936): Detected: Remote Desktop Enabled (localhost:58361) 2021-11-08 00:08:36 (18936): Preference change detected 2021-11-08 00:08:36 (18936): Setting CPU throttle for VM. (100%) 2021-11-08 00:08:36 (18936): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 900 seconds)) 2021-11-08 00:08:38 (18936): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-11-08 00:08:38 (18936): Guest Log: BIOS: Booting from Hard Disk... 2021-11-08 00:08:41 (18936): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-11-08 00:08:41 (18936): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2021-11-08 00:08:41 (18936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2021-11-08 00:08:47 (18936): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-11-08 00:08:47 (18936): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-11-08 00:08:51 (18936): Guest Log: Checking CVMFS... 2021-11-08 00:08:59 (18936): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2021-11-08 00:08:59 (18936): Guest Log: 00:00:00.000276 main Log opened 2021-11-08T00:08:57.281776000Z 2021-11-08 00:08:59 (18936): Guest Log: 00:00:00.000501 main OS Product: Linux 2021-11-08 00:08:59 (18936): Guest Log: 00:00:00.000568 main OS Release: 3.10.0-957.27.2.el7.x86_64 2021-11-08 00:08:59 (18936): Guest Log: 00:00:00.000627 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2021-11-08 00:08:59 (18936): Guest Log: 00:00:00.000687 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2021-11-08 00:08:59 (18936): Guest Log: 00:00:00.000689 main Process ID: 1470 2021-11-08 00:08:59 (18936): Guest Log: 00:00:00.000690 main Package type: LINUX_64BITS_GENERIC 2021-11-08 00:08:59 (18936): Guest Log: 00:00:00.002421 main 5.2.32 r132073 started. Verbose level = 0 2021-11-08 00:09:09 (18936): Guest Log: 00:00:10.006993 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 588 753 300 000ns (GuestNow=1 636 326 548 534 534 000 ns GuestLast=1 636 330 137 287 834 000 ns fSetTimeLastLoop=true ) 2021-11-08 01:48:36 (18936): Status Report: Elapsed Time: '6000.000000' 2021-11-08 01:48:36 (18936): Status Report: CPU Time: '100.046875' 2021-11-08 03:28:36 (18936): Status Report: Elapsed Time: '12000.000000' 2021-11-08 03:28:36 (18936): Status Report: CPU Time: '188.718750' 2021-11-08 05:08:37 (18936): Status Report: Elapsed Time: '18000.000000' 2021-11-08 05:08:37 (18936): Status Report: CPU Time: '266.234375' 2021-11-08 06:48:37 (18936): Status Report: Elapsed Time: '24000.000000' 2021-11-08 06:48:37 (18936): Status Report: CPU Time: '374.593750' 2021-11-08 08:28:38 (18936): Status Report: Elapsed Time: '30000.000000' 2021-11-08 08:28:38 (18936): Status Report: CPU Time: '481.078125' 2021-11-08 10:08:37 (18936): Status Report: Elapsed Time: '36000.000000' 2021-11-08 10:08:37 (18936): Status Report: CPU Time: '586.265625' 2021-11-08 11:48:38 (18936): Status Report: Elapsed Time: '42000.000000' 2021-11-08 11:48:38 (18936): Status Report: CPU Time: '670.781250' 2021-11-08 13:28:38 (18936): Status Report: Elapsed Time: '48000.000000' 2021-11-08 13:28:38 (18936): Status Report: CPU Time: '758.968750' 2021-11-08 15:08:38 (18936): Status Report: Elapsed Time: '54000.000000' 2021-11-08 15:08:38 (18936): Status Report: CPU Time: '863.906250' 2021-11-08 16:48:31 (18936): Status Report: Elapsed Time: '60000.000000' 2021-11-08 16:48:31 (18936): Status Report: CPU Time: '946.140625' 2021-11-08 18:28:31 (18936): Status Report: Elapsed Time: '66000.000000' 2021-11-08 18:28:31 (18936): Status Report: CPU Time: '1040.625000' 2021-11-08 20:08:31 (18936): Status Report: Elapsed Time: '72000.000000' 2021-11-08 20:08:31 (18936): Status Report: CPU Time: '1151.109375' 2021-11-08 21:48:31 (18936): Status Report: Elapsed Time: '78000.000000' 2021-11-08 21:48:31 (18936): Status Report: CPU Time: '1263.984375' 2021-11-08 23:28:32 (18936): Status Report: Elapsed Time: '84000.000000' 2021-11-08 23:28:32 (18936): Status Report: CPU Time: '1364.671875' 2021-11-09 01:08:32 (18936): Status Report: Elapsed Time: '90000.000000' 2021-11-09 01:08:32 (18936): Status Report: CPU Time: '1454.578125' 2021-11-09 02:48:32 (18936): Status Report: Elapsed Time: '96000.000000' 2021-11-09 02:48:32 (18936): Status Report: CPU Time: '1556.828125' 2021-11-09 04:28:33 (18936): Status Report: Elapsed Time: '102000.000000' 2021-11-09 04:28:33 (18936): Status Report: CPU Time: '1662.734375' 2021-11-09 06:08:33 (18936): Status Report: Elapsed Time: '108000.000000' 2021-11-09 06:08:33 (18936): Status Report: CPU Time: '1744.984375' 2021-11-09 07:48:33 (18936): Status Report: Elapsed Time: '114000.000000' 2021-11-09 07:48:33 (18936): Status Report: CPU Time: '1825.484375' 2021-11-09 09:28:33 (18936): Status Report: Elapsed Time: '120000.000000' 2021-11-09 09:28:33 (18936): Status Report: CPU Time: '1904.765625' 2021-11-09 11:08:33 (18936): Status Report: Elapsed Time: '126000.000000' 2021-11-09 11:08:33 (18936): Status Report: CPU Time: '1996.875000' 2021-11-09 12:48:28 (18936): Status Report: Elapsed Time: '132000.000000' 2021-11-09 12:48:28 (18936): Status Report: CPU Time: '2101.046875' 2021-11-09 14:28:28 (18936): Status Report: Elapsed Time: '138000.000000' 2021-11-09 14:28:28 (18936): Status Report: CPU Time: '2205.250000' 2021-11-09 16:08:28 (18936): Status Report: Elapsed Time: '144000.000000' 2021-11-09 16:08:28 (18936): Status Report: CPU Time: '2285.765625' 2021-11-09 17:48:28 (18936): Status Report: Elapsed Time: '150000.000000' 2021-11-09 17:48:28 (18936): Status Report: CPU Time: '2385.250000' 2021-11-09 19:28:28 (18936): Status Report: Elapsed Time: '156000.000000' 2021-11-09 19:28:28 (18936): Status Report: CPU Time: '2488.890625' 2021-11-09 21:08:28 (18936): Status Report: Elapsed Time: '162000.000000' 2021-11-09 21:08:28 (18936): Status Report: CPU Time: '2595.484375' 2021-11-09 22:48:28 (18936): Status Report: Elapsed Time: '168000.000000' 2021-11-09 22:48:28 (18936): Status Report: CPU Time: '2702.687500' 2021-11-10 00:28:28 (18936): Status Report: Elapsed Time: '174000.000000' 2021-11-10 00:28:28 (18936): Status Report: CPU Time: '2806.687500' 2021-11-10 02:08:28 (18936): Status Report: Elapsed Time: '180000.000000' 2021-11-10 02:08:28 (18936): Status Report: CPU Time: '2882.328125' 2021-11-10 03:48:28 (18936): Status Report: Elapsed Time: '186000.000000' 2021-11-10 03:48:28 (18936): Status Report: CPU Time: '2965.625000' 2021-11-10 05:28:29 (18936): Status Report: Elapsed Time: '192000.000000' 2021-11-10 05:28:29 (18936): Status Report: CPU Time: '3071.343750' 2021-11-10 07:08:29 (18936): Status Report: Elapsed Time: '198000.000000' 2021-11-10 07:08:29 (18936): Status Report: CPU Time: '3146.000000' 2021-11-10 08:48:30 (18936): Status Report: Elapsed Time: '204000.000000' 2021-11-10 08:48:30 (18936): Status Report: CPU Time: '3233.265625' 2021-11-10 10:28:30 (18936): Status Report: Elapsed Time: '210000.159233' 2021-11-10 10:28:30 (18936): Status Report: CPU Time: '3343.687500' 2021-11-10 12:08:30 (18936): Status Report: Elapsed Time: '216000.159233' 2021-11-10 12:08:30 (18936): Status Report: CPU Time: '3425.937500' 2021-11-10 13:48:25 (18936): Status Report: Elapsed Time: '222000.159233' 2021-11-10 13:48:25 (18936): Status Report: CPU Time: '3501.312500' 2021-11-10 15:28:25 (18936): Status Report: Elapsed Time: '228000.159233' 2021-11-10 15:28:25 (18936): Status Report: CPU Time: '3582.546875' 2021-11-10 17:08:25 (18936): Status Report: Elapsed Time: '234000.159233' 2021-11-10 17:08:25 (18936): Status Report: CPU Time: '3690.250000' 2021-11-10 17:47:05 (18936): VM state change detected. (old = 'Running', new = 'Saving') 2021-11-10 17:47:06 (18936): Stopping VM. 2021-11-10 17:47:06 (18936): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_d21395436dc8fe8c" savestate Output: 2021-11-10 17:47:06 (18936): VM did not stop when requested. 2021-11-10 17:47:06 (18936): VM was successfully terminated. 2021-11-10 17:50:28 (15864): Detected: vboxwrapper 26197 2021-11-10 17:50:28 (15864): Detected: BOINC client v7.7 2021-11-10 17:50:30 (15864): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2021-11-10 17:50:31 (15864): Starting VM using VBoxManage interface. (boinc_d21395436dc8fe8c, slot#5) 2021-11-10 17:50:41 (15864): Successfully started VM. (PID = '17268') 2021-11-10 17:50:41 (15864): Reporting VM Process ID to BOINC. 2021-11-10 17:50:41 (15864): Guest Log: BIOS: VirtualBox 6.1.28 2021-11-10 17:50:41 (15864): Guest Log: CPUID EDX: 0x178bfbff 2021-11-10 17:50:41 (15864): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-11-10 17:50:41 (15864): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-11-10 17:50:41 (15864): Detected: Web Application Enabled (http://localhost:58349) 2021-11-10 17:50:41 (15864): Detected: Remote Desktop Enabled (localhost:58361) 2021-11-10 17:50:41 (15864): Status Report: Elapsed Time: '236321.159233' 2021-11-10 17:50:41 (15864): Status Report: CPU Time: '3728.312500' 2021-11-10 17:50:41 (15864): Preference change detected 2021-11-10 17:50:41 (15864): Setting CPU throttle for VM. (100%) 2021-11-10 17:50:41 (15864): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 900 seconds)) 2021-11-10 17:50:43 (15864): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-11-10 17:50:43 (15864): Guest Log: BIOS: Booting from Hard Disk... 2021-11-10 17:50:46 (15864): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-11-10 17:50:46 (15864): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2021-11-10 17:50:46 (15864): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2021-11-10 17:50:53 (15864): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-11-10 17:50:53 (15864): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-11-10 17:50:57 (15864): Guest Log: Checking CVMFS... 2021-11-10 17:51:05 (15864): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2021-11-10 17:51:05 (15864): Guest Log: 00:00:00.000216 main Log opened 2021-11-10T17:51:03.108039000Z 2021-11-10 17:51:05 (15864): Guest Log: 00:00:00.000424 main OS Product: Linux 2021-11-10 17:51:05 (15864): Guest Log: 00:00:00.000483 main OS Release: 3.10.0-957.27.2.el7.x86_64 2021-11-10 17:51:05 (15864): Guest Log: 00:00:00.000535 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2021-11-10 17:51:05 (15864): Guest Log: 00:00:00.000589 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2021-11-10 17:51:05 (15864): Guest Log: 00:00:00.000590 main Process ID: 1389 2021-11-10 17:51:05 (15864): Guest Log: 00:00:00.000591 main Package type: LINUX_64BITS_GENERIC 2021-11-10 17:51:05 (15864): Guest Log: 00:00:00.002259 main 5.2.32 r132073 started. Verbose level = 0 2021-11-10 17:51:15 (15864): Guest Log: 00:00:10.006397 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 588 370 996 000ns (GuestNow=1 636 563 074 742 567 000 ns GuestLast=1 636 566 663 113 563 000 ns fSetTimeLastLoop=true ) 2021-11-10 19:30:42 (15864): Status Report: Elapsed Time: '242321.815102' 2021-11-10 19:30:42 (15864): Status Report: CPU Time: '3798.734375' 2021-11-10 21:10:42 (15864): Status Report: Elapsed Time: '248321.977972' 2021-11-10 21:10:42 (15864): Status Report: CPU Time: '3876.843750' 2021-11-10 22:50:42 (15864): Status Report: Elapsed Time: '254321.977972' 2021-11-10 22:50:42 (15864): Status Report: CPU Time: '3946.125000' 2021-11-11 00:30:42 (15864): Status Report: Elapsed Time: '260321.977972' 2021-11-11 00:30:42 (15864): Status Report: CPU Time: '4023.968750' 2021-11-11 02:10:42 (15864): Status Report: Elapsed Time: '266321.977972' 2021-11-11 02:10:42 (15864): Status Report: CPU Time: '4095.421875' 2021-11-11 03:50:44 (15864): Status Report: Elapsed Time: '272321.977972' 2021-11-11 03:50:44 (15864): Status Report: CPU Time: '4170.484375' 2021-11-11 05:30:44 (15864): Status Report: Elapsed Time: '278321.977972' 2021-11-11 05:30:44 (15864): Status Report: CPU Time: '4245.218750' 2021-11-11 07:10:44 (15864): Status Report: Elapsed Time: '284321.977972' 2021-11-11 07:10:44 (15864): Status Report: CPU Time: '4309.203125' 2021-11-11 08:50:44 (15864): Status Report: Elapsed Time: '290321.977972' 2021-11-11 08:50:44 (15864): Status Report: CPU Time: '4376.750000' 2021-11-11 10:30:44 (15864): Status Report: Elapsed Time: '296321.977972' 2021-11-11 10:30:44 (15864): Status Report: CPU Time: '4461.859375' 2021-11-11 12:10:39 (15864): Status Report: Elapsed Time: '302321.977972' 2021-11-11 12:10:39 (15864): Status Report: CPU Time: '4541.718750' 2021-11-11 13:50:39 (15864): Status Report: Elapsed Time: '308321.977972' 2021-11-11 13:50:39 (15864): Status Report: CPU Time: '4621.687500' 2021-11-11 15:30:39 (15864): Status Report: Elapsed Time: '314321.977972' 2021-11-11 15:30:39 (15864): Status Report: CPU Time: '4705.500000' 2021-11-11 17:10:39 (15864): Status Report: Elapsed Time: '320321.977972' 2021-11-11 17:10:39 (15864): Status Report: CPU Time: '4781.875000' 2021-11-11 18:50:39 (15864): Status Report: Elapsed Time: '326322.721741' 2021-11-11 18:50:39 (15864): Status Report: CPU Time: '4853.593750' 2021-11-11 20:30:39 (15864): Status Report: Elapsed Time: '332322.721741' 2021-11-11 20:30:39 (15864): Status Report: CPU Time: '4922.875000' 2021-11-11 22:10:39 (15864): Status Report: Elapsed Time: '338322.721741' 2021-11-11 22:10:39 (15864): Status Report: CPU Time: '5000.250000' 2021-11-11 23:50:39 (15864): Status Report: Elapsed Time: '344322.721741' 2021-11-11 23:50:39 (15864): Status Report: CPU Time: '5078.109375' 2021-11-12 01:30:40 (15864): Status Report: Elapsed Time: '350322.721741' 2021-11-12 01:30:40 (15864): Status Report: CPU Time: '5161.531250' 2021-11-12 03:10:39 (15864): Status Report: Elapsed Time: '356322.721741' 2021-11-12 03:10:39 (15864): Status Report: CPU Time: '5224.421875' 2021-11-12 04:50:40 (15864): Status Report: Elapsed Time: '362322.721741' 2021-11-12 04:50:40 (15864): Status Report: CPU Time: '5293.968750' 2021-11-12 06:30:40 (15864): Status Report: Elapsed Time: '368322.721741' 2021-11-12 06:30:40 (15864): Status Report: CPU Time: '5375.703125' 2021-11-12 08:10:40 (15864): Status Report: Elapsed Time: '374322.721741' 2021-11-12 08:10:40 (15864): Status Report: CPU Time: '5444.265625' 2021-11-12 09:50:40 (15864): Status Report: Elapsed Time: '380322.721741' 2021-11-12 09:50:40 (15864): Status Report: CPU Time: '5518.187500' 2021-11-12 11:30:40 (15864): Status Report: Elapsed Time: '386322.721741' 2021-11-12 11:30:40 (15864): Status Report: CPU Time: '5595.718750' 2021-11-12 13:10:34 (15864): Status Report: Elapsed Time: '392322.721741' 2021-11-12 13:10:34 (15864): Status Report: CPU Time: '5677.859375' 2021-11-12 14:50:34 (15864): Status Report: Elapsed Time: '398322.721741' 2021-11-12 14:50:34 (15864): Status Report: CPU Time: '5756.171875' 2021-11-12 16:30:34 (15864): Status Report: Elapsed Time: '404322.721741' 2021-11-12 16:30:34 (15864): Status Report: CPU Time: '5836.687500' 2021-11-12 18:10:34 (15864): Status Report: Elapsed Time: '410322.721741' 2021-11-12 18:10:34 (15864): Status Report: CPU Time: '5932.031250' 2021-11-12 19:50:34 (15864): Status Report: Elapsed Time: '416322.721741' 2021-11-12 19:50:34 (15864): Status Report: CPU Time: '5999.859375' 2021-11-12 21:30:34 (15864): Status Report: Elapsed Time: '422322.721741' 2021-11-12 21:30:34 (15864): Status Report: CPU Time: '6071.234375' 2021-11-12 23:10:34 (15864): Status Report: Elapsed Time: '428322.721741' 2021-11-12 23:10:34 (15864): Status Report: CPU Time: '6153.437500' 2021-11-13 00:50:34 (15864): Status Report: Elapsed Time: '434322.721741' 2021-11-13 00:50:34 (15864): Status Report: CPU Time: '6222.500000' 2021-11-13 02:30:34 (15864): Status Report: Elapsed Time: '440322.721741' 2021-11-13 02:30:34 (15864): Status Report: CPU Time: '6295.656250' 2021-11-13 04:10:34 (15864): Status Report: Elapsed Time: '446322.721741' 2021-11-13 04:10:34 (15864): Status Report: CPU Time: '6364.984375' 2021-11-13 05:50:34 (15864): Status Report: Elapsed Time: '452322.721741' 2021-11-13 05:50:34 (15864): Status Report: CPU Time: '6445.921875' 2021-11-13 07:30:34 (15864): Status Report: Elapsed Time: '458322.721741' 2021-11-13 07:30:34 (15864): Status Report: CPU Time: '6526.625000' 2021-11-13 09:10:34 (15864): Status Report: Elapsed Time: '464322.721741' 2021-11-13 09:10:34 (15864): Status Report: CPU Time: '6607.687500' 2021-11-13 10:50:34 (15864): Status Report: Elapsed Time: '470322.721741' 2021-11-13 10:50:34 (15864): Status Report: CPU Time: '6698.390625' 2021-11-13 12:30:29 (15864): Status Report: Elapsed Time: '476322.721741' 2021-11-13 12:30:29 (15864): Status Report: CPU Time: '6799.796875' 2021-11-13 14:10:29 (15864): Status Report: Elapsed Time: '482322.721741' 2021-11-13 14:10:29 (15864): Status Report: CPU Time: '6900.578125' 2021-11-13 15:50:29 (15864): Status Report: Elapsed Time: '488322.721741' 2021-11-13 15:50:29 (15864): Status Report: CPU Time: '6981.562500' 2021-11-13 17:30:29 (15864): Status Report: Elapsed Time: '494322.721741' 2021-11-13 17:30:29 (15864): Status Report: CPU Time: '7056.296875' 2021-11-13 19:10:29 (15864): Status Report: Elapsed Time: '500322.721741' 2021-11-13 19:10:29 (15864): Status Report: CPU Time: '7122.921875' 2021-11-13 20:50:29 (15864): Status Report: Elapsed Time: '506322.721741' 2021-11-13 20:50:29 (15864): Status Report: CPU Time: '7190.640625' 2021-11-13 22:30:29 (15864): Status Report: Elapsed Time: '512322.721741' 2021-11-13 22:30:29 (15864): Status Report: CPU Time: '7266.031250' 2021-11-14 00:10:29 (15864): Status Report: Elapsed Time: '518322.721741' 2021-11-14 00:10:29 (15864): Status Report: CPU Time: '7334.093750' 2021-11-14 01:50:29 (15864): Status Report: Elapsed Time: '524322.721741' 2021-11-14 01:50:29 (15864): Status Report: CPU Time: '7409.500000' 2021-11-14 03:30:29 (15864): Status Report: Elapsed Time: '530322.721741' 2021-11-14 03:30:29 (15864): Status Report: CPU Time: '7488.812500' 2021-11-14 05:10:29 (15864): Status Report: Elapsed Time: '536322.721741' 2021-11-14 05:10:29 (15864): Status Report: CPU Time: '7560.015625' 2021-11-14 06:50:29 (15864): Status Report: Elapsed Time: '542322.721741' 2021-11-14 06:50:29 (15864): Status Report: CPU Time: '7627.609375' 2021-11-14 08:30:29 (15864): Status Report: Elapsed Time: '548322.721741' 2021-11-14 08:30:29 (15864): Status Report: CPU Time: '7699.671875' 2021-11-14 10:10:29 (15864): Status Report: Elapsed Time: '554322.721741' 2021-11-14 10:10:29 (15864): Status Report: CPU Time: '7768.640625' 2021-11-14 11:50:23 (15864): Status Report: Elapsed Time: '560322.721741' 2021-11-14 11:50:23 (15864): Status Report: CPU Time: '7844.234375' 2021-11-14 13:30:23 (15864): Status Report: Elapsed Time: '566322.721741' 2021-11-14 13:30:23 (15864): Status Report: CPU Time: '7915.000000' 2021-11-14 15:10:23 (15864): Status Report: Elapsed Time: '572322.721741' 2021-11-14 15:10:23 (15864): Status Report: CPU Time: '7995.734375' 2021-11-14 16:50:23 (15864): Status Report: Elapsed Time: '578322.721741' 2021-11-14 16:50:23 (15864): Status Report: CPU Time: '8072.250000' 2021-11-14 18:30:23 (15864): Status Report: Elapsed Time: '584322.721741' 2021-11-14 18:30:23 (15864): Status Report: CPU Time: '8151.781250' 2021-11-14 20:10:23 (15864): Status Report: Elapsed Time: '590322.721741' 2021-11-14 20:10:23 (15864): Status Report: CPU Time: '8237.078125' 2021-11-14 21:50:23 (15864): Status Report: Elapsed Time: '596322.721741' 2021-11-14 21:50:23 (15864): Status Report: CPU Time: '8303.609375' 2021-11-14 23:30:23 (15864): Status Report: Elapsed Time: '602322.721741' 2021-11-14 23:30:23 (15864): Status Report: CPU Time: '8372.187500' 2021-11-15 01:10:23 (15864): Status Report: Elapsed Time: '608322.721741' 2021-11-15 01:10:23 (15864): Status Report: CPU Time: '8442.765625' 2021-11-15 02:50:23 (15864): Status Report: Elapsed Time: '614322.721741' 2021-11-15 02:50:23 (15864): Status Report: CPU Time: '8528.093750' 2021-11-15 04:30:23 (15864): Status Report: Elapsed Time: '620322.721741' 2021-11-15 04:30:23 (15864): Status Report: CPU Time: '8596.609375' 2021-11-15 06:10:24 (15864): Status Report: Elapsed Time: '626322.721741' 2021-11-15 06:10:24 (15864): Status Report: CPU Time: '8668.250000' 2021-11-15 07:50:24 (15864): Status Report: Elapsed Time: '632322.721741' 2021-11-15 07:50:24 (15864): Status Report: CPU Time: '8739.750000' 2021-11-15 09:30:24 (15864): Status Report: Elapsed Time: '638322.721741' 2021-11-15 09:30:24 (15864): Status Report: CPU Time: '8807.125000' 2021-11-15 11:10:24 (15864): Status Report: Elapsed Time: '644322.721741' 2021-11-15 11:10:24 (15864): Status Report: CPU Time: '8895.812500' 2021-11-15 12:50:18 (15864): Status Report: Elapsed Time: '650322.721741' 2021-11-15 12:50:18 (15864): Status Report: CPU Time: '8970.328125' 2021-11-15 14:30:19 (15864): Status Report: Elapsed Time: '656322.721741' 2021-11-15 14:30:19 (15864): Status Report: CPU Time: '9042.156250' 2021-11-15 16:10:18 (15864): Status Report: Elapsed Time: '662322.721741' 2021-11-15 16:10:18 (15864): Status Report: CPU Time: '9115.781250' 2021-11-15 17:50:18 (15864): Status Report: Elapsed Time: '668322.721741' 2021-11-15 17:50:19 (15864): Status Report: CPU Time: '9191.343750' 2021-11-15 19:30:18 (15864): Status Report: Elapsed Time: '674322.721741' 2021-11-15 19:30:18 (15864): Status Report: CPU Time: '9266.000000' 2021-11-15 21:10:18 (15864): Status Report: Elapsed Time: '680322.721741' 2021-11-15 21:10:18 (15864): Status Report: CPU Time: '9336.125000' 2021-11-15 22:50:18 (15864): Status Report: Elapsed Time: '686322.721741' 2021-11-15 22:50:18 (15864): Status Report: CPU Time: '9420.921875' 2021-11-16 00:30:18 (15864): Status Report: Elapsed Time: '692322.721741' 2021-11-16 00:30:18 (15864): Status Report: CPU Time: '9489.265625' 2021-11-16 02:10:18 (15864): Status Report: Elapsed Time: '698322.721741' 2021-11-16 02:10:18 (15864): Status Report: CPU Time: '9562.859375' 2021-11-16 03:50:18 (15864): Status Report: Elapsed Time: '704322.721741' 2021-11-16 03:50:18 (15864): Status Report: CPU Time: '9633.750000' 2021-11-16 05:30:18 (15864): Status Report: Elapsed Time: '710322.721741' 2021-11-16 05:30:18 (15864): Status Report: CPU Time: '9706.781250' 2021-11-16 07:10:18 (15864): Status Report: Elapsed Time: '716322.721741' 2021-11-16 07:10:18 (15864): Status Report: CPU Time: '9782.046875' 2021-11-16 08:50:19 (15864): Status Report: Elapsed Time: '722322.721741' 2021-11-16 08:50:19 (15864): Status Report: CPU Time: '9852.562500' 2021-11-16 10:30:19 (15864): Status Report: Elapsed Time: '728322.721741' 2021-11-16 10:30:19 (15864): Status Report: CPU Time: '9924.921875' 2021-11-16 12:10:14 (15864): Status Report: Elapsed Time: '734322.721741' 2021-11-16 12:10:14 (15864): Status Report: CPU Time: '10011.546875' 2021-11-16 13:50:14 (15864): Status Report: Elapsed Time: '740322.721741' 2021-11-16 13:50:14 (15864): Status Report: CPU Time: '10083.000000' 2021-11-16 15:30:14 (15864): Status Report: Elapsed Time: '746322.721741' 2021-11-16 15:30:14 (15864): Status Report: CPU Time: '10152.546875' 2021-11-16 17:10:14 (15864): Status Report: Elapsed Time: '752322.721741' 2021-11-16 17:10:14 (15864): Status Report: CPU Time: '10230.703125' 2021-11-16 18:50:14 (15864): Status Report: Elapsed Time: '758322.721741' 2021-11-16 18:50:14 (15864): Status Report: CPU Time: '10301.328125' 2021-11-16 20:30:14 (15864): Status Report: Elapsed Time: '764322.721741' 2021-11-16 20:30:14 (15864): Status Report: CPU Time: '10392.546875' 2021-11-16 22:10:14 (15864): Status Report: Elapsed Time: '770322.721741' 2021-11-16 22:10:14 (15864): Status Report: CPU Time: '10468.203125' 2021-11-16 23:50:14 (15864): Status Report: Elapsed Time: '776322.721741' 2021-11-16 23:50:14 (15864): Status Report: CPU Time: '10538.343750' 2021-11-17 01:30:14 (15864): Status Report: Elapsed Time: '782322.721741' 2021-11-17 01:30:14 (15864): Status Report: CPU Time: '10613.484375' 2021-11-17 03:10:14 (15864): Status Report: Elapsed Time: '788322.721741' 2021-11-17 03:10:14 (15864): Status Report: CPU Time: '10691.015625' 2021-11-17 04:50:16 (15864): Status Report: Elapsed Time: '794322.721741' 2021-11-17 04:50:16 (15864): Status Report: CPU Time: '10768.984375' 2021-11-17 06:30:16 (15864): Status Report: Elapsed Time: '800322.721741' 2021-11-17 06:30:16 (15864): Status Report: CPU Time: '10855.718750' 2021-11-17 08:10:16 (15864): Status Report: Elapsed Time: '806322.721741' 2021-11-17 08:10:16 (15864): Status Report: CPU Time: '10924.640625' 2021-11-17 09:50:16 (15864): Status Report: Elapsed Time: '812322.721741' 2021-11-17 09:50:16 (15864): Status Report: CPU Time: '10996.953125' 2021-11-17 11:30:16 (15864): Status Report: Elapsed Time: '818322.721741' 2021-11-17 11:30:16 (15864): Status Report: CPU Time: '11075.156250' 2021-11-17 13:10:16 (15864): Status Report: Elapsed Time: '824322.721741' 2021-11-17 13:10:16 (15864): Status Report: CPU Time: '11155.281250' 2021-11-17 14:50:16 (15864): Status Report: Elapsed Time: '830322.721741' 2021-11-17 14:50:16 (15864): Status Report: CPU Time: '11231.593750' 2021-11-17 16:30:09 (15864): Status Report: Elapsed Time: '836322.721741' 2021-11-17 16:30:09 (15864): Status Report: CPU Time: '11301.828125' 2021-11-17 18:10:10 (15864): Status Report: Elapsed Time: '842322.721741' 2021-11-17 18:10:10 (15864): Status Report: CPU Time: '11372.078125' 2021-11-17 19:50:10 (15864): Status Report: Elapsed Time: '848322.721741' 2021-11-17 19:50:10 (15864): Status Report: CPU Time: '11454.062500' 2021-11-17 21:30:10 (15864): Status Report: Elapsed Time: '854322.721741' 2021-11-17 21:30:10 (15864): Status Report: CPU Time: '11524.234375' 2021-11-17 23:10:10 (15864): Status Report: Elapsed Time: '860322.721741' 2021-11-17 23:10:10 (15864): Status Report: CPU Time: '11607.531250' 2021-11-18 00:50:10 (15864): Status Report: Elapsed Time: '866322.721741' 2021-11-18 00:50:10 (15864): Status Report: CPU Time: '11673.078125' 2021-11-18 02:30:10 (15864): Status Report: Elapsed Time: '872322.721741' 2021-11-18 02:30:10 (15864): Status Report: CPU Time: '11752.062500' 2021-11-18 04:10:10 (15864): Status Report: Elapsed Time: '878322.721741' 2021-11-18 04:10:10 (15864): Status Report: CPU Time: '11822.453125' 2021-11-18 05:50:12 (15864): Status Report: Elapsed Time: '884322.721741' 2021-11-18 05:50:12 (15864): Status Report: CPU Time: '11905.125000' 2021-11-18 07:30:12 (15864): Status Report: Elapsed Time: '890322.721741' 2021-11-18 07:30:12 (15864): Status Report: CPU Time: '11971.031250' 2021-11-18 09:10:12 (15864): Status Report: Elapsed Time: '896322.721741' 2021-11-18 09:10:12 (15864): Status Report: CPU Time: '12047.656250' 2021-11-18 10:50:13 (15864): Status Report: Elapsed Time: '902322.721741' 2021-11-18 10:50:13 (15864): Status Report: CPU Time: '12143.968750' 2021-11-18 12:30:09 (15864): Status Report: Elapsed Time: '908323.406505' 2021-11-18 12:30:09 (15864): Status Report: CPU Time: '12241.968750' 2021-11-18 14:10:09 (15864): Status Report: Elapsed Time: '914323.406505' 2021-11-18 14:10:09 (15864): Status Report: CPU Time: '12340.875000' 2021-11-18 15:50:09 (15864): Status Report: Elapsed Time: '920323.406505' 2021-11-18 15:50:09 (15864): Status Report: CPU Time: '12411.218750' 2021-11-18 17:30:09 (15864): Status Report: Elapsed Time: '926323.406505' 2021-11-18 17:30:09 (15864): Status Report: CPU Time: '12485.609375' 2021-11-18 19:10:09 (15864): Status Report: Elapsed Time: '932323.406505' 2021-11-18 19:10:09 (15864): Status Report: CPU Time: '12561.484375' 2021-11-18 20:50:09 (15864): Status Report: Elapsed Time: '938323.406505' 2021-11-18 20:50:09 (15864): Status Report: CPU Time: '12633.187500' 2021-11-18 22:30:09 (15864): Status Report: Elapsed Time: '944323.406505' 2021-11-18 22:30:09 (15864): Status Report: CPU Time: '12709.687500' 2021-11-19 00:10:09 (15864): Status Report: Elapsed Time: '950323.406505' 2021-11-19 00:10:09 (15864): Status Report: CPU Time: '12786.968750' 2021-11-19 01:50:09 (15864): Status Report: Elapsed Time: '956323.406505' 2021-11-19 01:50:09 (15864): Status Report: CPU Time: '12864.578125' 2021-11-19 03:30:09 (15864): Status Report: Elapsed Time: '962323.406505' 2021-11-19 03:30:09 (15864): Status Report: CPU Time: '12948.328125' 2021-11-19 05:10:12 (15864): Status Report: Elapsed Time: '968323.406505' 2021-11-19 05:10:12 (15864): Status Report: CPU Time: '13043.312500' 2021-11-19 06:50:12 (15864): Status Report: Elapsed Time: '974323.406505' 2021-11-19 06:50:12 (15864): Status Report: CPU Time: '13112.406250' 2021-11-19 08:30:12 (15864): Status Report: Elapsed Time: '980323.406505' 2021-11-19 08:30:12 (15864): Status Report: CPU Time: '13183.875000' 2021-11-19 10:10:12 (15864): Status Report: Elapsed Time: '986323.406505' 2021-11-19 10:10:12 (15864): Status Report: CPU Time: '13259.437500' 2021-11-19 11:50:12 (15864): Status Report: Elapsed Time: '992323.406505' 2021-11-19 11:50:12 (15864): Status Report: CPU Time: '13324.781250' 2021-11-19 13:30:06 (15864): Status Report: Elapsed Time: '998323.406505' 2021-11-19 13:30:06 (15864): Status Report: CPU Time: '13400.031250' 2021-11-19 15:10:07 (15864): Status Report: Elapsed Time: '1004323.406505' 2021-11-19 15:10:07 (15864): Status Report: CPU Time: '13482.875000' 2021-11-19 16:50:07 (15864): Status Report: Elapsed Time: '1010323.406505' 2021-11-19 16:50:07 (15864): Status Report: CPU Time: '13557.625000' 2021-11-19 18:30:07 (15864): Status Report: Elapsed Time: '1016323.406505' 2021-11-19 18:30:07 (15864): Status Report: CPU Time: '13634.593750' 2021-11-19 20:10:07 (15864): Status Report: Elapsed Time: '1022323.406505' 2021-11-19 20:10:07 (15864): Status Report: CPU Time: '13708.562500' 2021-11-19 21:50:07 (15864): Status Report: Elapsed Time: '1028323.406505' 2021-11-19 21:50:07 (15864): Status Report: CPU Time: '13770.734375' 2021-11-19 23:30:07 (15864): Status Report: Elapsed Time: '1034323.406505' 2021-11-19 23:30:07 (15864): Status Report: CPU Time: '13838.250000' 2021-11-20 01:10:07 (15864): Status Report: Elapsed Time: '1040323.406505' 2021-11-20 01:10:07 (15864): Status Report: CPU Time: '13904.609375' 2021-11-20 02:50:07 (15864): Status Report: Elapsed Time: '1046323.406505' 2021-11-20 02:50:07 (15864): Status Report: CPU Time: '13967.765625' 2021-11-20 04:30:11 (15864): Status Report: Elapsed Time: '1052323.406505' 2021-11-20 04:30:11 (15864): Status Report: CPU Time: '14062.109375' 2021-11-20 06:10:11 (15864): Status Report: Elapsed Time: '1058323.406505' 2021-11-20 06:10:11 (15864): Status Report: CPU Time: '14161.828125' 2021-11-20 07:50:11 (15864): Status Report: Elapsed Time: '1064323.406505' 2021-11-20 07:50:11 (15864): Status Report: CPU Time: '14254.312500' 2021-11-20 09:30:11 (15864): Status Report: Elapsed Time: '1070323.406505' 2021-11-20 09:30:11 (15864): Status Report: CPU Time: '14315.218750' 2021-11-20 11:10:11 (15864): Status Report: Elapsed Time: '1076323.406505' 2021-11-20 11:10:11 (15864): Status Report: CPU Time: '14379.562500' 2021-11-20 12:50:11 (15864): Status Report: Elapsed Time: '1082323.406505' 2021-11-20 12:50:11 (15864): Status Report: CPU Time: '14445.796875' 2021-11-20 14:30:11 (15864): Status Report: Elapsed Time: '1088323.406505' 2021-11-20 14:30:11 (15864): Status Report: CPU Time: '14517.562500' 2021-11-20 15:21:12 (15864): VM state change detected. (old = 'Running', new = 'Paused') 2021-11-20 17:30:41 (15864): VM state change detected. (old = 'Paused', new = 'Running') 2021-11-20 17:30:44 (15864): Guest Log: 237:29:29.727493 timesync vgsvcTimeSyncWorker: Radical host time change: 7 779 516 000 000ns (HostNow=1 637 425 790 256 000 000 ns HostLast=1 637 418 010 740 000 000 ns) 2021-11-20 17:30:54 (15864): Guest Log: 237:29:39.728303 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 765 793 299 000ns (GuestNow=1 637 425 800 256 902 000 ns GuestLast=1 637 418 034 463 603 000 ns fSetTimeLastLoop=true ) 2021-11-20 18:19:41 (15864): Status Report: Elapsed Time: '1094323.406505' 2021-11-20 18:19:41 (15864): Status Report: CPU Time: '14584.390625' 2021-11-20 19:59:41 (15864): Status Report: Elapsed Time: '1100323.406505' 2021-11-20 19:59:41 (15864): Status Report: CPU Time: '14666.625000' 2021-11-20 21:39:41 (15864): Status Report: Elapsed Time: '1106323.406505' 2021-11-20 21:39:41 (15864): Status Report: CPU Time: '14751.828125' 2021-11-20 21:55:03 (15864): VM state change detected. (old = 'Running', new = 'Saving') 2021-11-20 21:55:03 (15864): Stopping VM. 2021-11-20 21:55:04 (15864): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_d21395436dc8fe8c" savestate Output: 2021-11-20 21:55:04 (15864): VM did not stop when requested. 2021-11-20 21:55:04 (15864): VM was successfully terminated. 2021-11-23 17:17:56 (17764): Detected: vboxwrapper 26197 2021-11-23 17:17:56 (17764): Detected: BOINC client v7.7 2021-11-23 17:17:59 (17764): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2021-11-23 17:17:59 (17764): Starting VM using VBoxManage interface. (boinc_d21395436dc8fe8c, slot#5) 2021-11-23 17:18:11 (17764): Successfully started VM. (PID = '12996') 2021-11-23 17:18:11 (17764): Reporting VM Process ID to BOINC. 2021-11-23 17:18:11 (17764): Guest Log: BIOS: VirtualBox 6.1.28 2021-11-23 17:18:11 (17764): Guest Log: CPUID EDX: 0x178bfbff 2021-11-23 17:18:11 (17764): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-11-23 17:18:11 (17764): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-11-23 17:18:11 (17764): Detected: Web Application Enabled (http://localhost:58349) 2021-11-23 17:18:11 (17764): Detected: Remote Desktop Enabled (localhost:58361) 2021-11-23 17:18:11 (17764): Status Report: Elapsed Time: '1107245.406505' 2021-11-23 17:18:11 (17764): Status Report: CPU Time: '14764.078125' 2021-11-23 17:18:11 (17764): Preference change detected 2021-11-23 17:18:11 (17764): Setting CPU throttle for VM. (100%) 2021-11-23 17:18:11 (17764): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 360 seconds) or (Vbox_job.xml: 900 seconds)) 2021-11-23 17:18:13 (17764): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-11-23 17:18:13 (17764): Guest Log: BIOS: Booting from Hard Disk... 2021-11-23 17:18:16 (17764): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-11-23 17:18:16 (17764): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2021-11-23 17:18:16 (17764): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2021-11-23 17:18:22 (17764): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-11-23 17:18:22 (17764): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-11-23 17:18:27 (17764): Guest Log: Checking CVMFS... 2021-11-23 17:18:35 (17764): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2021-11-23 17:18:35 (17764): Guest Log: 00:00:00.000826 main Log opened 2021-11-23T17:18:33.693899000Z 2021-11-23 17:18:35 (17764): Guest Log: 00:00:00.001227 main OS Product: Linux 2021-11-23 17:18:35 (17764): Guest Log: 00:00:00.001297 main OS Release: 3.10.0-957.27.2.el7.x86_64 2021-11-23 17:18:35 (17764): Guest Log: 00:00:00.001352 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2021-11-23 17:18:35 (17764): Guest Log: 00:00:00.001494 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2021-11-23 17:18:35 (17764): Guest Log: 00:00:00.001496 main Process ID: 1606 2021-11-23 17:18:35 (17764): Guest Log: 00:00:00.001497 main Package type: LINUX_64BITS_GENERIC 2021-11-23 17:18:35 (17764): Guest Log: 00:00:00.005113 main 5.2.32 r132073 started. Verbose level = 0 2021-11-23 17:18:44 (17764): Guest Log: CVMFS is ok 2021-11-23 17:18:44 (17764): Guest Log: Mounting shared directory 2021-11-23 17:18:44 (17764): Guest Log: Copying input files 2021-11-23 17:18:45 (17764): Guest Log: 00:00:10.011064 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 588 732 060 000ns (GuestNow=1 637 684 324 971 498 000 ns GuestLast=1 637 687 913 703 558 000 ns fSetTimeLastLoop=true ) 2021-11-23 17:18:45 (17764): Guest Log: Copied input files into RunAtlas. 2021-11-23 17:18:46 (17764): Guest Log: copied the webapp to /var/www 2021-11-23 17:18:47 (17764): Guest Log: This vm does not need to setup an http proxy 2021-11-23 17:18:47 (17764): Guest Log: ATHENA_PROC_NUMBER=2 2021-11-23 17:18:47 (17764): Guest Log: *** Starting ATLAS job. (PandaID=5247131140 taskID=NULL&cor) *** 2021-11-23 17:53:05 (17764): Guest Log: *** Job finished *** 2021-11-23 17:53:05 (17764): Guest Log: *** The last 20 lines of the pilot log: *** 2021-11-23 17:53:05 (17764): Guest Log: *** Error codes and diagnostics *** 2021-11-23 17:53:05 (17764): Guest Log: "exeErrorCode": 0, 2021-11-23 17:53:05 (17764): Guest Log: "exeErrorDiag": "", 2021-11-23 17:53:05 (17764): Guest Log: "pilotErrorCode": 0, 2021-11-23 17:53:05 (17764): Guest Log: "pilotErrorDiag": "", 2021-11-23 17:53:05 (17764): Guest Log: *** Listing of results directory *** 2021-11-23 17:53:05 (17764): Guest Log: total 7908 2021-11-23 17:53:05 (17764): Guest Log: -rw-r--r--. 1 atlas atlas 344568 Nov 7 22:22 pilot2.tar.gz 2021-11-23 17:53:05 (17764): Guest Log: -rwx------. 1 atlas atlas 21085 Nov 7 22:59 runpilot2-wrapper.sh 2021-11-23 17:53:05 (17764): Guest Log: -rw-r--r--. 1 atlas atlas 3214 Nov 7 22:59 queuedata.json 2021-11-23 17:53:05 (17764): Guest Log: -rwxr-xr-x. 1 atlas atlas 8899 Nov 23 16:18 init_data.xml 2021-11-23 17:53:05 (17764): Guest Log: -rwxr-xr-x. 1 atlas atlas 354554 Nov 23 16:18 input.tar.gz 2021-11-23 17:53:05 (17764): Guest Log: -rwxr-xr-x. 1 atlas atlas 16537 Nov 23 16:18 start_atlas.sh 2021-11-23 17:53:05 (17764): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Nov 23 16:18 EVNT.04972714._000026.pool.root.1 -> /data/./ATLAS.root_0 2021-11-23 17:53:05 (17764): Guest Log: -rw-r--r--. 1 atlas atlas 2607 Nov 23 16:18 pandaJob.out 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 1093883 Nov 23 16:20 agis_schedconf.cvmfs.json 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 1945332 Nov 23 16:20 cric_ddmendpoints.json 2021-11-23 17:53:05 (17764): Guest Log: drwx------. 4 atlas atlas 260 Nov 23 16:20 pilot2 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 1538637 Nov 23 16:52 output.1.d1a2e285-11f3-450d-ace0-f22865c38fae_3756.pool.root 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 1020 Nov 23 16:52 memory_monitor_summary.json 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 453549 Nov 23 16:52 d1a2e285-11f3-450d-ace0-f22865c38fae_3756.1.job.log.tgz 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 7922 Nov 23 16:52 heartbeat.json 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 1805 Nov 23 16:53 pilotlog.txt 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 118152 Nov 23 16:53 d1a2e285-11f3-450d-ace0-f22865c38fae_3756.1.job.log 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 532 Nov 23 16:53 output.list 2021-11-23 17:53:05 (17764): Guest Log: -rw-r--r--. 1 atlas atlas 744 Nov 23 16:53 runtime_log 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 2129920 Nov 23 16:53 result.tar.gz 2021-11-23 17:53:05 (17764): Guest Log: -rw-r--r--. 1 atlas atlas 9391 Nov 23 16:53 runtime_log.err 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 569 Nov 23 16:53 hw9KDm4I63zn7Olcko1bjSoqABFKDmABFKDmZr2WDmhCGKDmsbgSbn.diag 2021-11-23 17:53:05 (17764): Guest Log: Looking for outputfile output.1.d1a2e285-11f3-450d-ace0-f22865c38fae_3756.pool.root 2021-11-23 17:53:05 (17764): Guest Log: HITS file was successfully produced 2021-11-23 17:53:05 (17764): Guest Log: -rw-------. 1 atlas atlas 1538637 Nov 23 16:52 /home/atlas/RunAtlas/output.1.d1a2e285-11f3-450d-ace0-f22865c38fae_3756.pool.root 2021-11-23 17:53:05 (17764): Guest Log: Successfully finished the ATLAS job! 2021-11-23 17:53:05 (17764): Guest Log: Copying the results back to the shared directory! 2021-11-23 17:53:06 (17764): Guest Log: *** Contents of shared directory: *** 2021-11-23 17:53:06 (17764): Guest Log: total 40316 2021-11-23 17:53:06 (17764): Guest Log: -rwxrwxrwx. 1 root root 37224345 Nov 7 23:08 ATLAS.root_0 2021-11-23 17:53:06 (17764): Guest Log: -rwxrwxrwx. 1 root root 1538637 Nov 23 16:52 HITS.pool.root.1 2021-11-23 17:53:06 (17764): Guest Log: -rwxrwxrwx. 1 root root 8899 Nov 7 23:08 init_data.xml 2021-11-23 17:53:06 (17764): Guest Log: -rwxrwxrwx. 1 root root 354554 Nov 7 23:00 input.tar.gz 2021-11-23 17:53:06 (17764): Guest Log: -rwxrwxrwx. 1 root root 2129920 Nov 23 2021 result.tar.gz 2021-11-23 17:53:06 (17764): Guest Log: -rwxrwxrwx. 1 root root 16537 Nov 7 23:00 start_atlas.sh 2021-11-23 17:53:06 (17764): Guest Log: *** Success! Shutting down the machine. *** 2021-11-23 17:53:06 (17764): VM Completion File Detected. 2021-11-23 17:53:06 (17764): Powering off VM. 2021-11-23 17:58:08 (17764): VM did not power off when requested. 2021-11-23 17:58:08 (17764): VM was successfully terminated. 2021-11-23 17:58:08 (17764): Deregistering VM. (boinc_d21395436dc8fe8c, slot#5) 2021-11-23 17:58:09 (17764): Removing network bandwidth throttle group from VM. 2021-11-23 17:58:09 (17764): Removing VM from VirtualBox. 17:58:15 (17764): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN