Name | CMS_538741_1568114009.217707_0 |
Workunit | 1935602 |
Created | 10 Sep 2019, 11:13:34 UTC |
Sent | 10 Sep 2019, 13:39:13 UTC |
Report deadline | 17 Sep 2019, 13:39:13 UTC |
Received | 11 Sep 2019, 21:52:41 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 3584 |
Run time | 17 hours 33 min 37 sec |
CPU time | 16 hours 41 min 40 sec |
Validate state | Valid |
Credit | 452.12 |
Device peak FLOPS | 2.85 GFLOPS |
Application version | CMS Simulation v49.00 (vbox64_mt_mcore_cms) windows_x86_64 |
Peak working set size | 81.37 MB |
Peak swap size | 112.51 MB |
Peak disk usage | 3.87 GB |
<core_client_version>7.14.2</core_client_version> <![CDATA[ <stderr_txt> 2019-09-10 08:40:19 (14116): Detected: vboxwrapper 26197 2019-09-10 08:40:19 (14116): Detected: BOINC client v7.7 2019-09-10 08:40:19 (14116): Status Report: Launching vboxsvc.exe. (PID = '3864') 2019-09-10 08:40:22 (14116): Detected: VirtualBox VboxManage Interface (Version: 5.2.18) 2019-09-10 08:40:22 (14116): Detected: Sandbox Configuration Enabled 2019-09-10 08:40:23 (14116): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-10 08:40:23 (14116): Successfully copied 'init_data.xml' to the shared directory. 2019-09-10 08:40:24 (14116): Create VM. (boinc_7503d82ced25e9ba, slot#1) 2019-09-10 08:40:24 (14116): Setting Memory Size for VM. (1896MB) 2019-09-10 08:40:25 (14116): Setting CPU Count for VM. (1) 2019-09-10 08:40:25 (14116): Setting Chipset Options for VM. 2019-09-10 08:40:25 (14116): Setting Boot Options for VM. 2019-09-10 08:40:26 (14116): Setting Network Configuration for NAT. 2019-09-10 08:40:26 (14116): Enabling VM Network Access. 2019-09-10 08:40:26 (14116): Disabling USB Support for VM. 2019-09-10 08:40:27 (14116): Disabling COM Port Support for VM. 2019-09-10 08:40:27 (14116): Disabling LPT Port Support for VM. 2019-09-10 08:40:27 (14116): Disabling Audio Support for VM. 2019-09-10 08:40:27 (14116): Disabling Clipboard Support for VM. 2019-09-10 08:40:28 (14116): Disabling Drag and Drop Support for VM. 2019-09-10 08:40:28 (14116): Adding storage controller(s) to VM. 2019-09-10 08:40:28 (14116): Adding virtual disk drive to VM. (vm_image.vdi) 2019-09-10 08:40:29 (14116): Adding VirtualBox Guest Additions to VM. 2019-09-10 08:40:29 (14116): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-09-10 08:40:29 (14116): forwarding host port 52794 to guest port 80 2019-09-10 08:40:30 (14116): Enabling remote desktop for VM. 2019-09-10 08:40:30 (14116): Enabling shared directory for VM. 2019-09-10 08:40:31 (14116): Starting VM using VBoxManage interface. (boinc_7503d82ced25e9ba, slot#1) 2019-09-10 08:40:41 (14116): Successfully started VM. (PID = '13020') 2019-09-10 08:40:41 (14116): Reporting VM Process ID to BOINC. 2019-09-10 08:40:41 (14116): Guest Log: BIOS: VirtualBox 5.2.18 2019-09-10 08:40:41 (14116): Guest Log: CPUID EDX: 0x078bfbff 2019-09-10 08:40:41 (14116): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-10 08:40:41 (14116): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-09-10 08:40:41 (14116): Detected: Web Application Enabled (http://localhost:52794) 2019-09-10 08:40:41 (14116): Detected: Remote Desktop Enabled (localhost:52795) 2019-09-10 08:40:42 (14116): Preference change detected 2019-09-10 08:40:42 (14116): Setting CPU throttle for VM. (100%) 2019-09-10 08:40:42 (14116): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-10 08:40:44 (14116): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-10 08:40:44 (14116): Guest Log: BIOS: Booting from Hard Disk... 2019-09-10 08:40:47 (14116): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-10 08:40:47 (14116): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-10 08:41:15 (14116): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-10 08:41:15 (14116): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-10 08:41:54 (14116): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-10 08:41:54 (14116): Guest Log: 00:00:00.000352 main Log opened 2019-09-10T13:41:56.001124000Z 2019-09-10 08:41:54 (14116): Guest Log: 00:00:00.000641 main OS Product: Linux 2019-09-10 08:41:54 (14116): Guest Log: 00:00:00.000702 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-10 08:41:54 (14116): Guest Log: 00:00:00.000804 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-10 08:41:54 (14116): Guest Log: 00:00:00.000886 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-10 08:41:54 (14116): Guest Log: 00:00:00.000889 main Process ID: 2962 2019-09-10 08:41:54 (14116): Guest Log: 00:00:00.000891 main Package type: LINUX_64BITS_GENERIC 2019-09-10 08:41:54 (14116): Guest Log: 00:00:00.003306 main 5.2.6 r120293 started. Verbose level = 0 2019-09-10 08:42:37 (14116): Guest Log: [INFO] Mounting the shared directory 2019-09-10 08:42:38 (14116): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-10 08:42:38 (14116): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-10 08:42:38 (14116): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-10 08:42:38 (14116): Guest Log: [DEBUG] 0 2019-09-10 08:42:38 (14116): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-10 08:42:38 (14116): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-10 08:42:38 (14116): Guest Log: [DEBUG] 0 2019-09-10 08:42:39 (14116): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-10 08:42:39 (14116): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-10 08:42:39 (14116): Guest Log: [DEBUG] 0 2019-09-10 08:43:48 (14116): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-10 08:43:52 (14116): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-10 08:43:54 (14116): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2019-09-10 08:43:54 (14116): Guest Log: 2.4.4.0 3701 1 25832 10207 3 1 1454385 10240001 2 65024 0 3 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-09-10 08:44:11 (14116): Guest Log: [INFO] Reading volunteer information 2019-09-10 08:44:11 (14116): Guest Log: [INFO] Volunteer: Coleslaw (55) 2019-09-10 08:44:11 (14116): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-10 08:44:12 (14116): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-10 08:44:13 (14116): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-10 08:44:15 (14116): Guest Log: [INFO] Running the fast benchmark. 2019-09-10 08:49:02 (14116): Guest Log: [INFO] Machine performance 1.79 HEPSPEC06 2019-09-10 08:49:02 (14116): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-10 08:49:04 (14116): Guest Log: [DEBUG] HTCondor ping 2019-09-10 08:49:06 (14116): Guest Log: [DEBUG] 0 2019-09-10 10:21:35 (14116): Status Report: Job Duration: '64800.000000' 2019-09-10 10:21:35 (14116): Status Report: Elapsed Time: '6000.000000' 2019-09-10 10:21:35 (14116): Status Report: CPU Time: '5460.265625' 2019-09-10 11:35:24 (14116): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-10 11:53:52 (14116): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-10 12:21:03 (14116): Status Report: Job Duration: '64800.000000' 2019-09-10 12:21:03 (14116): Status Report: Elapsed Time: '12000.421482' 2019-09-10 12:21:03 (14116): Status Report: CPU Time: '11289.593750' 2019-09-10 12:54:17 (14116): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-10 13:55:12 (14116): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-10 13:55:15 (14116): Guest Log: 03:54:00.939890 timesync vgsvcTimeSyncWorker: Radical host time change: 3 664 843 000 000ns (HostNow=1 568 141 714 583 000 000 ns HostLast=1 568 138 049 740 000 000 ns) 2019-09-10 13:55:25 (14116): Guest Log: 03:54:10.941243 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 766 068 192 000ns (GuestNow=1 568 141 724 587 959 000 ns GuestLast=1 568 136 958 519 767 000 ns fSetTimeLastLoop=true ) 2019-09-10 14:11:41 (14116): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-10 15:29:08 (14116): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-10 15:29:12 (14116): Guest Log: 04:10:31.002681 timesync vgsvcTimeSyncWorker: Radical host time change: 4 658 000 000 000ns (HostNow=1 568 147 352 445 000 000 ns HostLast=1 568 142 694 445 000 000 ns) 2019-09-10 15:29:23 (14116): Guest Log: 04:10:41.003645 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 657 796 658 000ns (GuestNow=1 568 147 362 446 014 000 ns GuestLast=1 568 142 704 649 356 000 ns fSetTimeLastLoop=true ) 2019-09-10 16:20:34 (14116): Status Report: Job Duration: '64800.000000' 2019-09-10 16:20:34 (14116): Status Report: Elapsed Time: '18000.421482' 2019-09-10 16:20:34 (14116): Status Report: CPU Time: '17128.125000' 2019-09-10 17:16:01 (14116): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-10 17:55:33 (14116): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-10 17:55:36 (14116): Guest Log: 05:57:21.507103 timesync vgsvcTimeSyncWorker: Radical host time change: 2 382 564 000 000ns (HostNow=1 568 156 136 468 000 000 ns HostLast=1 568 153 753 904 000 000 ns) 2019-09-10 17:55:47 (14116): Guest Log: 05:57:31.508158 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 382 419 954 000ns (GuestNow=1 568 156 146 532 227 000 ns GuestLast=1 568 153 764 112 273 000 ns fSetTimeLastLoop=true ) 2019-09-10 18:41:30 (14116): Status Report: Job Duration: '64800.000000' 2019-09-10 18:41:30 (14116): Status Report: Elapsed Time: '24001.214529' 2019-09-10 18:41:30 (14116): Status Report: CPU Time: '22952.671875' 2019-09-10 20:22:32 (14116): Status Report: Job Duration: '64800.000000' 2019-09-10 20:22:32 (14116): Status Report: Elapsed Time: '30001.214529' 2019-09-10 20:22:32 (14116): Status Report: CPU Time: '28980.562500' 2019-09-10 20:26:07 (14116): Stopping VM. 2019-09-10 20:26:10 (14116): Error in stop VM for VM: -2147024891 Command: VBoxManage -q controlvm "boinc_7503d82ced25e9ba" savestate Output: VBoxManage.exe: error: Failed to create the VirtualBox object! VBoxManage.exe: error: The object is not ready VBoxManage.exe: error: Details: code E_ACCESSDENIED (0x80070005), component VirtualBoxClientWrap, interface IVirtualBoxClient 2019-09-10 20:26:10 (14116): VM did not stop when requested. 2019-09-10 20:26:10 (14116): VM was successfully terminated. 2019-09-10 20:35:59 (10888): Detected: vboxwrapper 26197 2019-09-10 20:35:59 (10888): Detected: BOINC client v7.7 2019-09-10 20:35:59 (10888): Status Report: Launching vboxsvc.exe. (PID = '11256') 2019-09-10 20:36:01 (10888): Detected: VirtualBox VboxManage Interface (Version: 5.2.18) 2019-09-10 20:36:01 (10888): Detected: Sandbox Configuration Enabled 2019-09-10 20:36:02 (10888): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-10 20:36:03 (10888): Starting VM using VBoxManage interface. (boinc_7503d82ced25e9ba, slot#1) 2019-09-10 20:36:16 (10888): Successfully started VM. (PID = '8012') 2019-09-10 20:36:16 (10888): Reporting VM Process ID to BOINC. 2019-09-10 20:36:16 (10888): Guest Log: BIOS: VirtualBox 5.2.18 2019-09-10 20:36:16 (10888): Guest Log: CPUID EDX: 0x078bfbff 2019-09-10 20:36:16 (10888): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-10 20:36:16 (10888): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-09-10 20:36:16 (10888): Detected: Web Application Enabled (http://localhost:52794) 2019-09-10 20:36:16 (10888): Detected: Remote Desktop Enabled (localhost:52795) 2019-09-10 20:36:16 (10888): Status Report: Job Duration: '64800.000000' 2019-09-10 20:36:16 (10888): Status Report: Elapsed Time: '30213.214529' 2019-09-10 20:36:16 (10888): Status Report: CPU Time: '29192.218750' 2019-09-10 20:36:16 (10888): Preference change detected 2019-09-10 20:36:16 (10888): Setting CPU throttle for VM. (100%) 2019-09-10 20:36:16 (10888): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-10 20:36:18 (10888): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-10 20:36:18 (10888): Guest Log: BIOS: Booting from Hard Disk... 2019-09-10 20:36:21 (10888): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-10 20:36:21 (10888): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-10 20:36:50 (10888): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-10 20:36:50 (10888): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-10 20:37:37 (10888): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-10 20:37:37 (10888): Guest Log: 00:00:00.000492 main Log opened 2019-09-11T01:37:35.229788000Z 2019-09-10 20:37:37 (10888): Guest Log: 00:00:00.000779 main OS Product: Linux 2019-09-10 20:37:37 (10888): Guest Log: 00:00:00.000844 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-10 20:37:37 (10888): Guest Log: 00:00:00.000903 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-10 20:37:37 (10888): Guest Log: 00:00:00.001228 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-10 20:37:37 (10888): Guest Log: 00:00:00.001269 main Process ID: 2907 2019-09-10 20:37:37 (10888): Guest Log: 00:00:00.001272 main Package type: LINUX_64BITS_GENERIC 2019-09-10 20:37:37 (10888): Guest Log: 00:00:00.003583 main 5.2.6 r120293 started. Verbose level = 0 2019-09-10 20:38:31 (10888): Guest Log: [INFO] Mounting the shared directory 2019-09-10 20:38:31 (10888): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-10 20:38:31 (10888): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-10 20:38:32 (10888): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-10 20:38:32 (10888): Guest Log: [DEBUG] 0 2019-09-10 20:38:32 (10888): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-10 20:38:32 (10888): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-10 20:38:32 (10888): Guest Log: [DEBUG] 0 2019-09-10 20:38:32 (10888): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-10 20:38:33 (10888): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-10 20:38:33 (10888): Guest Log: [DEBUG] 0 2019-09-10 20:39:45 (10888): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-10 20:39:48 (10888): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-10 20:39:50 (10888): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2019-09-10 20:39:50 (10888): Guest Log: 2.4.4.0 3626 1 25560 10211 3 1 2453480 10240001 2 65024 0 3 100 1 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-09-10 20:40:01 (10888): Guest Log: [INFO] Reading volunteer information 2019-09-10 20:40:02 (10888): Guest Log: [INFO] Volunteer: Coleslaw (55) 2019-09-10 20:40:02 (10888): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-10 20:40:02 (10888): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-10 20:40:04 (10888): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-10 20:40:07 (10888): Guest Log: [INFO] Running the fast benchmark. 2019-09-10 20:45:23 (10888): Guest Log: [INFO] Machine performance 1.62 HEPSPEC06 2019-09-10 20:45:23 (10888): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-10 20:45:26 (10888): Guest Log: [DEBUG] HTCondor ping 2019-09-10 20:45:28 (10888): Guest Log: [DEBUG] 0 2019-09-10 22:17:20 (10888): Status Report: Job Duration: '64800.000000' 2019-09-10 22:17:20 (10888): Status Report: Elapsed Time: '36213.214529' 2019-09-10 22:17:20 (10888): Status Report: CPU Time: '34556.781250' 2019-09-10 23:35:47 (10888): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-11 00:05:07 (10888): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-11 00:27:47 (10888): Status Report: Job Duration: '64800.000000' 2019-09-11 00:27:47 (10888): Status Report: Elapsed Time: '42213.214529' 2019-09-11 00:27:47 (10888): Status Report: CPU Time: '40578.640625' 2019-09-11 01:26:25 (10888): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-11 03:15:14 (10888): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-11 03:15:16 (10888): Guest Log: 04:19:31.180776 timesync vgsvcTimeSyncWorker: Radical host time change: 6 538 560 000 000ns (HostNow=1 568 189 715 433 000 000 ns HostLast=1 568 183 176 873 000 000 ns) 2019-09-11 03:15:26 (10888): Guest Log: 04:19:41.181349 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 538 447 508 000ns (GuestNow=1 568 189 725 587 377 000 ns GuestLast=1 568 183 187 139 869 000 ns fSetTimeLastLoop=true ) 2019-09-11 03:57:39 (10888): Status Report: Job Duration: '64800.000000' 2019-09-11 03:57:39 (10888): Status Report: Elapsed Time: '48213.214529' 2019-09-11 03:57:39 (10888): Status Report: CPU Time: '46426.296875' 2019-09-11 04:33:47 (10888): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-11 05:02:18 (10888): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-11 06:02:44 (10888): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-11 06:58:31 (10888): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-11 06:58:34 (10888): Guest Log: 06:38:31.650699 timesync vgsvcTimeSyncWorker: Radical host time change: 3 356 907 000 000ns (HostNow=1 568 203 113 871 000 000 ns HostLast=1 568 199 756 964 000 000 ns) 2019-09-11 06:58:44 (10888): Guest Log: 06:38:41.651694 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 356 909 860 000ns (GuestNow=1 568 203 123 915 015 000 ns GuestLast=1 568 199 767 005 155 000 ns fSetTimeLastLoop=true ) 2019-09-11 07:03:08 (10888): Status Report: Job Duration: '64800.000000' 2019-09-11 07:03:08 (10888): Status Report: Elapsed Time: '54213.214529' 2019-09-11 07:03:08 (10888): Status Report: CPU Time: '52454.640625' 2019-09-11 07:59:13 (10888): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-11 08:00:23 (10888): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-11 08:45:25 (10888): Status Report: Job Duration: '64800.000000' 2019-09-11 08:45:25 (10888): Status Report: Elapsed Time: '60213.214529' 2019-09-11 08:45:25 (10888): Status Report: CPU Time: '58492.328125' 2019-09-11 09:00:48 (10888): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-11 15:50:10 (10888): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-11 15:50:13 (10888): Guest Log: 08:39:42.169077 timesync vgsvcTimeSyncWorker: Radical host time change: 24 571 977 000 000ns (HostNow=1 568 235 013 408 000 000 ns HostLast=1 568 210 441 431 000 000 ns) 2019-09-11 15:50:23 (10888): Guest Log: 08:39:52.169708 timesync vgsvcTimeSyncWorker: Radical guest time change: 24 636 960 570 000ns (GuestNow=1 568 235 023 414 987 000 ns GuestLast=1 568 210 386 454 417 000 ns fSetTimeLastLoop=true ) 2019-09-11 15:55:12 (10888): VM state change detected. (old = 'Running', new = 'Paused') 2019-09-11 16:29:08 (10888): VM state change detected. (old = 'Paused', new = 'Running') 2019-09-11 16:29:09 (10888): Guest Log: 08:44:42.181024 timesync vgsvcTimeSyncWorker: Radical host time change: 2 045 212 000 000ns (HostNow=1 568 237 348 493 000 000 ns HostLast=1 568 235 303 281 000 000 ns) 2019-09-11 16:29:19 (10888): Guest Log: 08:44:52.182054 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 045 067 886 000ns (GuestNow=1 568 237 358 494 104 000 ns GuestLast=1 568 235 313 426 218 000 ns fSetTimeLastLoop=true ) 2019-09-11 16:46:14 (10888): Guest Log: [INFO] Condor exited with return value N/A. 2019-09-11 16:46:14 (10888): Guest Log: [INFO] Shutting Down. 2019-09-11 16:46:14 (10888): VM Completion File Detected. 2019-09-11 16:46:14 (10888): VM Completion Message: Condor exited with return value N/A. . 2019-09-11 16:46:14 (10888): Powering off VM. 2019-09-11 16:51:15 (10888): VM did not power off when requested. 2019-09-11 16:51:15 (10888): VM was successfully terminated. 2019-09-11 16:51:15 (10888): Deregistering VM. (boinc_7503d82ced25e9ba, slot#1) 2019-09-11 16:51:46 (10888): Removing network bandwidth throttle group from VM. 2019-09-11 16:52:17 (10888): Removing VM from VirtualBox. 16:52:29 (10888): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN